2010-03-04 16:43:01,857 (http-0.0.0.0-8443-5) [ ControlServlet.java:134:INFO ] [[[main] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:43:01,858 (http-0.0.0.0-8443-5) [ VisitHandler.java:221:INFO ] Found visitorId [10301] in cookie

2010-03-04 16:43:01,930 (http-0.0.0.0-8443-5) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0090s, 376 requests, 162 views in jndi:/0.0.0.0/content/WEB-INF/controller.xml

2010-03-04 16:43:01,962 (http-0.0.0.0-8443-5) [ RequestHandler.java:716:INFO ] Rendering View [FindWebSite], sessionId=8C9D46B03F31D4C137ABB820E8B63700.jvm1

2010-03-04 16:43:02,006 (http-0.0.0.0-8443-5) [ ScreenFactory.java:129:INFO ] Got 11 screens in 0.016s from: file:/var/www/sitios/ofbiz/applications/content/widget/WebSiteScreens.xml

2010-03-04 16:43:02,055 (http-0.0.0.0-8443-5) [ ScreenFactory.java:129:INFO ] Got 13 screens in 0.01s from: file:/var/www/sitios/ofbiz/applications/content/widget/CommonScreens.xml

2010-03-04 16:43:02,459 (http-0.0.0.0-8443-5) [ ControlServlet.java:312:INFO ] [[[main] Request Done- total:0.602,since last([main] Request Be...):0.602]]

2010-03-04 16:43:12,822 (http-0.0.0.0-8443-5) [ ControlServlet.java:134:INFO ] [[[EditWebSite] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:43:12,844 (http-0.0.0.0-8443-5) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-04 16:43:12,848 (http-0.0.0.0-8443-5) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-04 16:43:12,856 (http-0.0.0.0-8443-5) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.018s, 376 requests, 162 views in jndi:/0.0.0.0/content/WEB-INF/controller.xml

2010-03-04 16:43:12,865 (http-0.0.0.0-8443-5) [ RequestHandler.java:716:INFO ] Rendering View [EditWebSite], sessionId=8C9D46B03F31D4C137ABB820E8B63700.jvm1

2010-03-04 16:43:12,931 (http-0.0.0.0-8443-5) [ ScreenFactory.java:129:INFO ] Got 11 screens in 0.01s from: file:/var/www/sitios/ofbiz/applications/content/widget/WebSiteScreens.xml

2010-03-04 16:43:12,944 (http-0.0.0.0-8443-5) [ ScreenFactory.java:129:INFO ] Got 13 screens in 0.0090s from: file:/var/www/sitios/ofbiz/applications/content/widget/CommonScreens.xml

2010-03-04 16:43:12,956 (http-0.0.0.0-8443-5) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-04 16:43:13,017 (http-0.0.0.0-8443-5) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-04 16:43:13,476 (http-0.0.0.0-8443-5) [ ControlServlet.java:312:INFO ] [[[EditWebSite] Request Done- total:0.654,since last([EditWebSite] Req...):0.654]]

2010-03-04 16:43:19,040 (http-0.0.0.0-8443-5) [ ControlServlet.java:134:INFO ] [[[updateWebSite] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:43:19,245 (http-0.0.0.0-8443-5) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission CONTENTMGR_UPDATE

2010-03-04 16:43:19,255 (http-0.0.0.0-8443-5) [ ServiceDispatcher.java:586:INFO ] Sync service [content/contentManagerPermission] finished in [65] milliseconds

2010-03-04 16:43:19,474 (http-0.0.0.0-8443-5) [ ServiceDispatcher.java:586:INFO ] Sync service [content/updateWebSite] finished in [285] milliseconds

2010-03-04 16:43:19,475 (http-0.0.0.0-8443-5) [ RequestHandler.java:612:INFO ] Ran Event [service:#updateWebSite] from [request], result is [success]

2010-03-04 16:43:19,475 (http-0.0.0.0-8443-5) [ RequestHandler.java:716:INFO ] Rendering View [EditWebSite], sessionId=8C9D46B03F31D4C137ABB820E8B63700.jvm1

2010-03-04 16:43:19,788 (http-0.0.0.0-8443-5) [ ControlServlet.java:312:INFO ] [[[updateWebSite] Request Done- total:0.747,since last([updateWebSite] R...):0.747]]

2010-03-04 16:43:34,688 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[main] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:43:34,706 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-04 16:43:34,710 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-04 16:43:34,733 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0080s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-04 16:43:34,740 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.039s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-04 16:43:34,780 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [main], sessionId=517B258C39B790655F3089FD520CB665.jvm1

2010-03-04 16:43:34,855 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 32 screens in 0.016s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/PartyScreens.xml

2010-03-04 16:43:34,912 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.05s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-04 16:43:34,927 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0090s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-04 16:43:34,999 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-04 16:43:35,331 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[main] Request Done- total:0.643,since last([main] Request Be...):0.643]]

2010-03-04 16:43:37,866 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[findparty] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:43:37,883 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [findparty], sessionId=517B258C39B790655F3089FD520CB665.jvm1

2010-03-04 16:43:37,898 (http-0.0.0.0-8443-6) [ PartyServices.java:1395:INFO ] In findParty mainCond=((statusId IS NULL OR statusId <> 'PARTY_DISABLED'))

2010-03-04 16:43:38,155 (http-0.0.0.0-8443-6) [ ServiceDispatcher.java:586:INFO ] Sync service [partymgr/getPartyMainRole] finished in [60] milliseconds

2010-03-04 16:43:38,706 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[findparty] Request Done- total:0.839,since last([findparty] Reque...):0.839]]

2010-03-04 16:43:43,249 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[viewprofile] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:43:43,260 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [viewprofile], sessionId=517B258C39B790655F3089FD520CB665.jvm1

2010-03-04 16:43:43,518 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.011s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/ProfileScreens.xml

2010-03-04 16:43:44,063 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[viewprofile] Request Done- total:0.813,since last([viewprofile] Req...):0.813]]

2010-03-04 16:44:22,685 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[Preferences] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:44:22,704 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-04 16:44:22,708 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-04 16:44:22,732 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0090s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-04 16:44:22,739 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.041s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-04 16:44:22,750 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [Preferences], sessionId=517B258C39B790655F3089FD520CB665.jvm1

2010-03-04 16:44:22,832 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 32 screens in 0.016s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/PartyScreens.xml

2010-03-04 16:44:22,877 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.0090s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-04 16:44:22,923 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0090s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-04 16:44:22,983 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-04 16:44:23,421 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[Preferences] Request Done- total:0.735,since last([Preferences] Req...):0.735]]

2010-03-04 16:44:27,875 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[viewroles] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:44:27,886 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [viewroles], sessionId=517B258C39B790655F3089FD520CB665.jvm1

2010-03-04 16:44:28,317 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[viewroles] Request Done- total:0.441,since last([viewroles] Reque...):0.441]]

2010-03-04 16:44:31,901 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[viewidentifications] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:44:31,913 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [viewidentifications], sessionId=517B258C39B790655F3089FD520CB665.jvm1

2010-03-04 16:44:31,921 (http-0.0.0.0-8443-6) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:PartyIdentification][partyId,system(java.lang.String)]

2010-03-04 16:44:32,250 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[viewidentifications] Request Done- total:0.348,since last([viewidentificati...):0.348]]

2010-03-04 16:44:35,927 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[linkparty] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:44:35,945 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-04 16:44:35,949 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-04 16:44:35,972 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0080s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-04 16:44:35,979 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.039s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-04 16:44:35,990 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [linkparty], sessionId=517B258C39B790655F3089FD520CB665.jvm1

2010-03-04 16:44:36,052 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 32 screens in 0.016s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/PartyScreens.xml

2010-03-04 16:44:36,234 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.0090s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-04 16:44:36,251 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-04 16:44:36,310 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-04 16:44:36,693 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[linkparty] Request Done- total:0.765,since last([linkparty] Reque...):0.765]]

2010-03-04 16:44:44,027 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[PartyFinancialHistory] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:44:44,038 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [PartyFinancialHistory], sessionId=517B258C39B790655F3089FD520CB665.jvm1

2010-03-04 16:44:47,085 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-04 16:44:47,088 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-04 16:44:47,114 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0090s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-04 16:44:47,120 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.042s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-04 16:44:47,152 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[PartyFinancialHistory] Request Done- total:3.125,since last([PartyFinancialHi...):3.125]]

2010-03-04 16:44:55,607 (http-0.0.0.0-8443-6) [ControlEventListener.java:63 :INFO ] Creating session: 281230C5327FFC286434B03706ADA6DD.jvm1

2010-03-04 16:44:55,608 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[FindFinAccount] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:44:55,608 (http-0.0.0.0-8443-6) [ VisitHandler.java:221:INFO ] Found visitorId [10301] in cookie

2010-03-04 16:44:55,681 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.012s, 473 requests, 228 views in jndi:/0.0.0.0/accounting/WEB-INF/controller.xml

2010-03-04 16:44:55,710 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [FindFinAccount], sessionId=281230C5327FFC286434B03706ADA6DD.jvm1

2010-03-04 16:44:56,412 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 19 screens in 0.028s from: file:/var/www/sitios/ofbiz/applications/accounting/widget/FinAccountScreens.xml

2010-03-04 16:44:56,414 (http-0.0.0.0-8443-6) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:FinAccount]

2010-03-04 16:44:56,431 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 11 screens in 0.017s from: file:/var/www/sitios/ofbiz/applications/accounting/widget/CommonScreens.xml

2010-03-04 16:44:56,464 (http-0.0.0.0-8443-6) [ UtilProperties.java:875:INFO ] ResourceBundle AccountingHelpUrls (en_US) created in 0.029s with 101 properties

2010-03-04 16:44:56,473 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-04 16:44:56,533 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-04 16:44:56,756 (http-0.0.0.0-8443-6) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_VIEW

2010-03-04 16:44:56,996 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[FindFinAccount] Request Done- total:1.388,since last([FindFinAccount] ...):1.388]]

2010-03-04 16:45:10,809 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[main] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:45:10,882 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-04 16:45:10,886 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-04 16:45:10,897 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.021s, 473 requests, 228 views in jndi:/0.0.0.0/accounting/WEB-INF/controller.xml

2010-03-04 16:45:10,908 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [main], sessionId=281230C5327FFC286434B03706ADA6DD.jvm1

2010-03-04 16:45:10,958 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 11 screens in 0.01s from: file:/var/www/sitios/ofbiz/applications/accounting/widget/CommonScreens.xml

2010-03-04 16:45:11,050 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-04 16:45:11,109 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-04 16:45:11,507 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[main] Request Done- total:0.698,since last([main] Request Be...):0.698]]

2010-03-04 16:45:16,851 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[findPayments] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:45:16,861 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [findPayments], sessionId=281230C5327FFC286434B03706ADA6DD.jvm1

2010-03-04 16:45:16,903 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 11 screens in 0.035s from: file:/var/www/sitios/ofbiz/applications/accounting/widget/PaymentScreens.xml

2010-03-04 16:45:17,207 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[findPayments] Request Done- total:0.356,since last([findPayments] Re...):0.356]]

2010-03-04 16:45:20,237 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[LookupVisualThemes] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:45:20,248 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [LookupVisualThemes], sessionId=281230C5327FFC286434B03706ADA6DD.jvm1

2010-03-04 16:45:20,278 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 5 screens in 0.023s from: file:/var/www/sitios/ofbiz/framework/common/widget/LookupScreens.xml

2010-03-04 16:45:20,368 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[LookupVisualThemes] Request Done- total:0.13,since last([LookupVisualThem...):0.13]]

2010-03-04 16:45:40,764 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[main] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:45:40,790 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-04 16:45:40,794 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-04 16:45:40,804 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.021s, 473 requests, 228 views in jndi:/0.0.0.0/accounting/WEB-INF/controller.xml

2010-03-04 16:45:40,815 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [main], sessionId=281230C5327FFC286434B03706ADA6DD.jvm1

2010-03-04 16:45:40,866 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 11 screens in 0.01s from: file:/var/www/sitios/ofbiz/applications/accounting/widget/CommonScreens.xml

2010-03-04 16:45:40,885 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-04 16:45:40,946 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-04 16:45:41,303 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[main] Request Done- total:0.539,since last([main] Request Be...):0.539]]

2010-03-04 16:45:46,350 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[findPayments] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 16:45:46,361 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [findPayments], sessionId=281230C5327FFC286434B03706ADA6DD.jvm1

2010-03-04 16:45:46,378 (http-0.0.0.0-8443-6) [ ScreenFactory.java:129:INFO ] Got 11 screens in 0.011s from: file:/var/www/sitios/ofbiz/applications/accounting/widget/PaymentScreens.xml

2010-03-04 16:45:46,786 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[findPayments] Request Done- total:0.436,since last([findPayments] Re...):0.436]]

2010-03-04 17:10:35,794 (default-invoker-Thread-4442) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-4442] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-04 17:10:35,814 (default-invoker-Thread-4442) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3d302157[15044] -- Next runtime: Thu Mar 04 18:10:35 CET 2010

2010-03-04 17:10:35,857 (default-invoker-Thread-4442) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-04 17:10:35,861 (default-invoker-Thread-4442) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-04 17:10:36,074 (default-invoker-Thread-4442) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [257] milliseconds

2010-03-04 17:43:35,325 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: 8C9D46B03F31D4C137ABB820E8B63700.jvm1

2010-03-04 17:43:35,355 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: EA8E7006A7BEE1EFC4A210DA381C75C3.jvm1

2010-03-04 17:45:35,395 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: 517B258C39B790655F3089FD520CB665.jvm1

2010-03-04 17:46:35,425 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: 281230C5327FFC286434B03706ADA6DD.jvm1

2010-03-04 18:10:38,712 (default-invoker-Thread-4445) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-4445] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-04 18:10:38,748 (default-invoker-Thread-4445) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3e8852c9[15045] -- Next runtime: Thu Mar 04 19:10:38 CET 2010

2010-03-04 18:10:38,798 (default-invoker-Thread-4445) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-04 18:10:38,812 (default-invoker-Thread-4445) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-04 18:10:38,813 (default-invoker-Thread-4445) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [55] milliseconds

2010-03-04 18:10:38,879 (default-invoker-Thread-4445) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [122] milliseconds

2010-03-04 19:10:40,830 (default-invoker-Thread-5720) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5720] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-04 19:10:40,862 (default-invoker-Thread-5720) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5ccf03a5[15046] -- Next runtime: Thu Mar 04 20:10:40 CET 2010

2010-03-04 19:10:40,906 (default-invoker-Thread-5720) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-04 19:10:40,917 (default-invoker-Thread-5720) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-04 19:10:40,976 (default-invoker-Thread-5720) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-04 20:10:42,917 (default-invoker-Thread-5721) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5721] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-04 20:10:42,939 (default-invoker-Thread-5721) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@75b8dbfe[15047] -- Next runtime: Thu Mar 04 21:10:42 CET 2010

2010-03-04 20:10:42,984 (default-invoker-Thread-5721) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-04 20:10:42,995 (default-invoker-Thread-5721) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-04 20:10:43,054 (default-invoker-Thread-5721) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-04 21:10:45,760 (default-invoker-Thread-5721) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5721] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-04 21:10:45,791 (default-invoker-Thread-5721) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@ee11b9c[15048] -- Next runtime: Thu Mar 04 22:10:45 CET 2010

2010-03-04 21:10:45,836 (default-invoker-Thread-5721) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-04 21:10:45,847 (default-invoker-Thread-5721) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-04 21:10:45,907 (default-invoker-Thread-5721) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-04 22:10:47,843 (default-invoker-Thread-5720) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5720] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-04 22:10:47,868 (default-invoker-Thread-5720) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@71b8889f[15049] -- Next runtime: Thu Mar 04 23:10:47 CET 2010

2010-03-04 22:10:47,913 (default-invoker-Thread-5720) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-04 22:10:47,924 (default-invoker-Thread-5720) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-04 22:10:47,984 (default-invoker-Thread-5720) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-04 23:10:50,693 (default-invoker-Thread-5719) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5719] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-04 23:10:50,714 (default-invoker-Thread-5719) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@159fec8d[15050] -- Next runtime: Fri Mar 05 00:10:50 CET 2010

2010-03-04 23:10:50,759 (default-invoker-Thread-5719) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-04 23:10:50,771 (default-invoker-Thread-5719) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-04 23:10:50,831 (default-invoker-Thread-5719) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [110] milliseconds

2010-03-04 23:43:16,956 (http-0.0.0.0-8443-3) [ControlEventListener.java:63 :INFO ] Creating session: 230014AA3CB8B4B3E7979A8CC64F3422.jvm1

2010-03-04 23:43:16,956 (http-0.0.0.0-8443-3) [ ControlServlet.java:134:INFO ] [[[main] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 23:43:16,957 (http-0.0.0.0-8443-3) [ VisitHandler.java:221:INFO ] Found visitorId [10000] in cookie

2010-03-04 23:43:17,014 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-04 23:43:17,019 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-04 23:43:17,042 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0080s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-04 23:43:17,049 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.04s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-04 23:43:17,071 (http-0.0.0.0-8443-3) [ RequestHandler.java:716:INFO ] Rendering View [login], sessionId=230014AA3CB8B4B3E7979A8CC64F3422.jvm1

2010-03-04 23:43:17,128 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-04 23:43:17,137 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-04 23:43:17,149 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-04 23:43:17,153 (http-0.0.0.0-8443-3) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]

2010-03-04 23:43:17,473 (http-0.0.0.0-8443-3) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [ServerHitBin]; curSeqId=11250, maxSeqId=11260, bankSize=10

2010-03-04 23:43:17,476 (http-0.0.0.0-8443-3) [ ControlServlet.java:312:INFO ] [[[main] Request Done- total:0.52,since last([main] Request Be...):0.52]]

2010-03-04 23:48:59,061 (http-0.0.0.0-8443-4) [ ControlServlet.java:134:INFO ] [[[login] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 23:48:59,080 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-04 23:48:59,084 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-04 23:48:59,108 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0090s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-04 23:48:59,114 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.039s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-04 23:48:59,244 (http-0.0.0.0-8443-4) [ ServiceDispatcher.java:586:INFO ] Sync service [partymgr/userLogin] finished in [107] milliseconds

2010-03-04 23:48:59,326 (http-0.0.0.0-8443-4) [ LoginWorker.java:558:INFO ] Running autoLogin check.

2010-03-04 23:48:59,330 (http-0.0.0.0-8443-4) [ RequestHandler.java:612:INFO ] Ran Event [java:org.ofbiz.webapp.control.LoginWorker#login] from [request], result is [success]

2010-03-04 23:48:59,338 (http-0.0.0.0-8443-4) [ RequestHandler.java:460:INFO ] [Doing Previous Request]: /main sessionId=230014AA3CB8B4B3E7979A8CC64F3422.jvm1

2010-03-04 23:48:59,340 (http-0.0.0.0-8443-4) [ RequestHandler.java:672:INFO ] Sending redirect to: [/partymgr/control/main], sessionId=230014AA3CB8B4B3E7979A8CC64F3422.jvm1

2010-03-04 23:48:59,386 (http-0.0.0.0-8443-4) [ ControlServlet.java:312:INFO ] [[[login] Request Done- total:0.324,since last([login] Request B...):0.324]]

2010-03-04 23:48:59,531 (http-0.0.0.0-8443-4) [ ControlServlet.java:134:INFO ] [[[main] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 23:48:59,552 (http-0.0.0.0-8443-4) [ RequestHandler.java:716:INFO ] Rendering View [main], sessionId=230014AA3CB8B4B3E7979A8CC64F3422.jvm1

2010-03-04 23:48:59,612 (http-0.0.0.0-8443-4) [ ScreenFactory.java:129:INFO ] Got 32 screens in 0.016s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/PartyScreens.xml

2010-03-04 23:48:59,645 (http-0.0.0.0-8443-4) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-04 23:48:59,658 (http-0.0.0.0-8443-4) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-04 23:48:59,795 (http-0.0.0.0-8443-4) [ ServiceDispatcher.java:586:INFO ] Sync service [partymgr/getLastSystemInfoNote] finished in [69] milliseconds

2010-03-04 23:48:59,819 (http-0.0.0.0-8443-4) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.011s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-04 23:49:00,124 (http-0.0.0.0-8443-4) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [ServerHitBin]; curSeqId=11260, maxSeqId=11270, bankSize=10

2010-03-04 23:49:00,135 (http-0.0.0.0-8443-4) [ ControlServlet.java:312:INFO ] [[[main] Request Done- total:0.604,since last([main] Request Be...):0.604]]

2010-03-04 23:49:07,869 (http-0.0.0.0-8443-4) [ ControlServlet.java:134:INFO ] [[[findparty] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 23:49:07,880 (http-0.0.0.0-8443-4) [ RequestHandler.java:716:INFO ] Rendering View [findparty], sessionId=230014AA3CB8B4B3E7979A8CC64F3422.jvm1

2010-03-04 23:49:07,902 (http-0.0.0.0-8443-4) [ PartyServices.java:1395:INFO ] In findParty mainCond=((statusId IS NULL OR statusId <> 'PARTY_DISABLED'))

2010-03-04 23:49:08,192 (http-0.0.0.0-8443-4) [ ServiceDispatcher.java:586:INFO ] Sync service [partymgr/getPartyMainRole] finished in [70] milliseconds

2010-03-04 23:49:08,678 (http-0.0.0.0-8443-4) [ ControlServlet.java:312:INFO ] [[[findparty] Request Done- total:0.809,since last([findparty] Reque...):0.809]]

2010-03-04 23:49:14,185 (http-0.0.0.0-8443-5) [ ControlServlet.java:134:INFO ] [[[viewprofile] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 23:49:14,203 (http-0.0.0.0-8443-5) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-04 23:49:14,207 (http-0.0.0.0-8443-5) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-04 23:49:14,230 (http-0.0.0.0-8443-5) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0090s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-04 23:49:14,236 (http-0.0.0.0-8443-5) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.038s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-04 23:49:14,250 (http-0.0.0.0-8443-5) [ RequestHandler.java:716:INFO ] Rendering View [viewprofile], sessionId=230014AA3CB8B4B3E7979A8CC64F3422.jvm1

2010-03-04 23:49:14,305 (http-0.0.0.0-8443-5) [ ScreenFactory.java:129:INFO ] Got 32 screens in 0.015s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/PartyScreens.xml

2010-03-04 23:49:14,374 (http-0.0.0.0-8443-5) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.0090s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-04 23:49:14,392 (http-0.0.0.0-8443-5) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-04 23:49:14,453 (http-0.0.0.0-8443-5) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-04 23:49:14,675 (http-0.0.0.0-8443-5) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.011s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/ProfileScreens.xml

2010-03-04 23:49:15,152 (http-0.0.0.0-8443-5) [ ServiceDispatcher.java:586:INFO ] Sync service [partymgr/getOrderedSummaryInformation] finished in [184] milliseconds

2010-03-04 23:49:15,667 (http-0.0.0.0-8443-5) [ ControlServlet.java:312:INFO ] [[[viewprofile] Request Done- total:1.481,since last([viewprofile] Req...):1.481]]

2010-03-04 23:49:18,958 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[viewroles] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 23:49:18,969 (http-0.0.0.0-8443-6) [ RequestHandler.java:716:INFO ] Rendering View [viewroles], sessionId=230014AA3CB8B4B3E7979A8CC64F3422.jvm1

2010-03-04 23:49:19,384 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[viewroles] Request Done- total:0.426,since last([viewroles] Reque...):0.426]]

2010-03-04 23:49:22,379 (http-0.0.0.0-8443-5) [ ControlServlet.java:134:INFO ] [[[Preferences] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-04 23:49:22,389 (http-0.0.0.0-8443-5) [ RequestHandler.java:716:INFO ] Rendering View [Preferences], sessionId=230014AA3CB8B4B3E7979A8CC64F3422.jvm1

2010-03-04 23:49:22,718 (http-0.0.0.0-8443-5) [ ControlServlet.java:312:INFO ] [[[Preferences] Request Done- total:0.339,since last([Preferences] Req...):0.339]]

2010-03-05 00:00:12,806 (default-invoker-Thread-5720) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5720] received job [Run Auto-Reorders] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:00:12,806 (default-invoker-Thread-5718) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5718] received job [Replacement Held Order Auto-Cancel] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:00:12,806 (default-invoker-Thread-5721) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5721] received job [Purge Old Store Auto-Entered Promos] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:00:12,806 (default-invoker-Thread-5719) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5719] received job [BackOrder Notification] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:00:12,813 (default-invoker-Thread-5722) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5722] received job [Cancels all orders after date] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:00:12,850 (default-invoker-Thread-5718) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4d1f63e5[15026] -- Next runtime: Sat Mar 06 00:00:00 CET 2010

2010-03-05 00:00:12,850 (default-invoker-Thread-5721) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@47d776f1[15024] -- Next runtime: Sat Mar 06 00:00:00 CET 2010

2010-03-05 00:00:12,853 (default-invoker-Thread-5722) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@331f00af[15023] -- Next runtime: Sat Mar 06 00:00:00 CET 2010

2010-03-05 00:00:12,854 (default-invoker-Thread-5720) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3865fb61[15025] -- Next runtime: Sat Mar 06 00:00:00 CET 2010

2010-03-05 00:00:12,854 (default-invoker-Thread-5719) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2f5aba34[15027] -- Next runtime: Sat Mar 06 00:00:00 CET 2010

2010-03-05 00:00:12,954 (default-invoker-Thread-5718) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/autoCancelReplacementOrders] finished in [98] milliseconds

2010-03-05 00:00:12,991 (default-invoker-Thread-5718) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5718] received job [Extend expired Subscriptions] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:00:13,027 (default-invoker-Thread-5718) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7d657590[15022] -- Next runtime: Sat Mar 06 00:00:00 CET 2010

2010-03-05 00:00:13,064 (default-invoker-Thread-5720) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/runShoppingListAutoReorder] finished in [204] milliseconds

2010-03-05 00:00:13,095 (default-invoker-Thread-5720) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5720] received job [Purge Old Jobs] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:00:13,117 (default-invoker-Thread-5719) [ InventoryServices.java:380:INFO ] OOS Inventory Items: 0

2010-03-05 00:00:13,117 (default-invoker-Thread-5719) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/checkInventoryAvailability] finished in [260] milliseconds

2010-03-05 00:00:13,127 (default-invoker-Thread-5719) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5719] received job [Re-Try Failed Auths] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:00:13,139 (default-invoker-Thread-5720) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6fc8405d[15021] -- Next runtime: Sat Mar 06 00:00:00 CET 2010

2010-03-05 00:00:13,139 (default-invoker-Thread-5718) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/runSubscriptionAutoReorders] finished in [95] milliseconds

2010-03-05 00:00:13,140 (default-invoker-Thread-5719) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@468bc7dd[15020] -- Next runtime: Sat Mar 06 00:00:00 CET 2010

2010-03-05 00:00:13,147 (default-invoker-Thread-5721) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/purgeOldStoreAutoPromos] finished in [283] milliseconds

2010-03-05 00:00:13,158 (default-invoker-Thread-5720) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-05 00:00:13,196 (default-invoker-Thread-5718) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5718] received job [Re-Try Failed Auths NSF] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:00:13,225 (default-invoker-Thread-5721) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5721] received job [Clear EntitySyncRemove Info] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:00:13,240 (default-invoker-Thread-5718) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4aa3ce8f[15019] -- Next runtime: Sat Mar 06 00:00:00 CET 2010

2010-03-05 00:00:13,241 (default-invoker-Thread-5721) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@484e3491[15018] -- Next runtime: Sat Mar 06 00:00:00 CET 2010

2010-03-05 00:00:13,246 (default-invoker-Thread-5721) [ EntitySyncServices.java:600:INFO ] Running cleanSyncRemoveInfo

2010-03-05 00:00:13,249 (default-invoker-Thread-5722) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/cancelAllBackOrders] finished in [384] milliseconds

2010-03-05 00:00:13,251 (default-invoker-Thread-5720) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-05 00:00:13,260 (default-invoker-Thread-5719) [PaymentGatewayServices.java:2611:INFO ] Processing failed order re-auth(s)

2010-03-05 00:00:13,260 (default-invoker-Thread-5719) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/retryFailedAuths] finished in [101] milliseconds

2010-03-05 00:00:13,266 (default-invoker-Thread-5718) [PaymentGatewayServices.java:2660:INFO ] Processing failed order re-auth(s)

2010-03-05 00:00:13,268 (default-invoker-Thread-5722) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-5722] received job [Create Also Bought Product Associations] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:00:13,281 (default-invoker-Thread-5722) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@63dd1037[15017] -- Next runtime: Sat Mar 06 00:00:00 CET 2010

2010-03-05 00:00:13,323 (default-invoker-Thread-5721) [ EntitySyncServices.java:627:INFO ] In cleanSyncRemoveInfo removed [1] values with TX timestamp before [2010-03-04 23:36:13.275]

2010-03-05 00:00:13,324 (default-invoker-Thread-5721) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/cleanSyncRemoveInfo] finished in [80] milliseconds

2010-03-05 00:00:13,329 (default-invoker-Thread-5720) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/purgeOldJobs] finished in [104] milliseconds

2010-03-05 00:10:53,255 (default-invoker-Thread-6926) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-6926] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 00:10:53,286 (default-invoker-Thread-6926) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2388894e[15051] -- Next runtime: Fri Mar 05 01:10:53 CET 2010

2010-03-05 00:10:53,327 (default-invoker-Thread-6926) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 00:10:53,331 (default-invoker-Thread-6926) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 00:10:53,406 (default-invoker-Thread-6926) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [117] milliseconds

2010-03-05 00:49:37,140 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: 230014AA3CB8B4B3E7979A8CC64F3422.jvm1

2010-03-05 01:10:55,660 (default-invoker-Thread-6930) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-6930] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 01:10:55,722 (default-invoker-Thread-6930) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1ba1e5b1[15063] -- Next runtime: Fri Mar 05 02:10:55 CET 2010

2010-03-05 01:10:55,949 (default-invoker-Thread-6930) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 01:10:56,031 (default-invoker-Thread-6930) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 01:10:56,032 (default-invoker-Thread-6930) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [119] milliseconds

2010-03-05 01:10:56,090 (default-invoker-Thread-6930) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [178] milliseconds

2010-03-05 02:10:57,757 (default-invoker-Thread-6929) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-6929] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 02:10:57,796 (default-invoker-Thread-6929) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@68033567[15064] -- Next runtime: Fri Mar 05 03:10:57 CET 2010

2010-03-05 02:10:57,841 (default-invoker-Thread-6929) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 02:10:57,852 (default-invoker-Thread-6929) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 02:10:57,911 (default-invoker-Thread-6929) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-05 03:11:00,652 (default-invoker-Thread-6927) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-6927] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 03:11:00,680 (default-invoker-Thread-6927) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6dd24081[15065] -- Next runtime: Fri Mar 05 04:11:00 CET 2010

2010-03-05 03:11:00,728 (default-invoker-Thread-6927) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 03:11:00,739 (default-invoker-Thread-6927) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 03:11:00,797 (default-invoker-Thread-6927) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-05 04:11:02,735 (default-invoker-Thread-6930) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-6930] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 04:11:02,776 (default-invoker-Thread-6930) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6d56bc61[15066] -- Next runtime: Fri Mar 05 05:11:02 CET 2010

2010-03-05 04:11:02,820 (default-invoker-Thread-6930) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 04:11:02,831 (default-invoker-Thread-6930) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 04:11:02,890 (default-invoker-Thread-6930) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-05 05:11:04,825 (default-invoker-Thread-7897) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-7897] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 05:11:04,845 (default-invoker-Thread-7897) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@396364b8[15067] -- Next runtime: Fri Mar 05 06:11:04 CET 2010

2010-03-05 05:11:04,890 (default-invoker-Thread-7897) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 05:11:04,901 (default-invoker-Thread-7897) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 05:11:04,960 (default-invoker-Thread-7897) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-05 06:11:07,668 (default-invoker-Thread-7899) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-7899] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 06:11:07,695 (default-invoker-Thread-7899) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@19ea6c48[15068] -- Next runtime: Fri Mar 05 07:11:07 CET 2010

2010-03-05 06:11:07,740 (default-invoker-Thread-7899) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 06:11:07,751 (default-invoker-Thread-7899) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 06:11:07,809 (default-invoker-Thread-7899) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-05 07:11:09,792 (default-invoker-Thread-7898) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-7898] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 07:11:09,821 (default-invoker-Thread-7898) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@28b234da[15069] -- Next runtime: Fri Mar 05 08:11:09 CET 2010

2010-03-05 07:11:09,865 (default-invoker-Thread-7898) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 07:11:09,876 (default-invoker-Thread-7898) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 07:11:09,935 (default-invoker-Thread-7898) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-05 08:11:12,648 (default-invoker-Thread-7896) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-7896] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 08:11:12,672 (default-invoker-Thread-7896) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1e5f4889[15070] -- Next runtime: Fri Mar 05 09:11:12 CET 2010

2010-03-05 08:11:12,718 (default-invoker-Thread-7896) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 08:11:12,729 (default-invoker-Thread-7896) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 08:11:12,787 (default-invoker-Thread-7896) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-05 09:11:15,492 (default-invoker-Thread-7896) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-7896] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 09:11:15,534 (default-invoker-Thread-7896) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@509a5fc2[15071] -- Next runtime: Fri Mar 05 10:11:15 CET 2010

2010-03-05 09:11:15,579 (default-invoker-Thread-7896) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 09:11:15,590 (default-invoker-Thread-7896) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 09:11:15,649 (default-invoker-Thread-7896) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-05 10:11:17,597 (default-invoker-Thread-8866) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-8866] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 10:11:17,821 (default-invoker-Thread-8866) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@e511702[15072] -- Next runtime: Fri Mar 05 11:11:17 CET 2010

2010-03-05 10:11:17,867 (default-invoker-Thread-8866) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 10:11:17,878 (default-invoker-Thread-8866) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 10:11:17,939 (default-invoker-Thread-8866) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [110] milliseconds

2010-03-05 11:11:19,692 (default-invoker-Thread-8869) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-8869] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 11:11:19,818 (default-invoker-Thread-8869) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@237a936a[15073] -- Next runtime: Fri Mar 05 12:11:19 CET 2010

2010-03-05 11:11:19,863 (default-invoker-Thread-8869) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 11:11:19,874 (default-invoker-Thread-8869) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 11:11:19,933 (default-invoker-Thread-8869) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-05 11:16:53,238 (http-0.0.0.0-8443-3) [ControlEventListener.java:63 :INFO ] Creating session: B40B9A768D1713BE0145798470A1F985.jvm1

2010-03-05 11:16:53,238 (http-0.0.0.0-8443-3) [ ControlServlet.java:134:INFO ] [[[Preferences] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-05 11:16:53,239 (http-0.0.0.0-8443-3) [ VisitHandler.java:221:INFO ] Found visitorId [10000] in cookie

2010-03-05 11:16:53,834 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-05 11:16:53,849 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-05 11:16:53,883 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.01s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-05 11:16:53,889 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.073s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-05 11:16:53,892 (http-0.0.0.0-8443-3) [ RequestHandler.java:716:INFO ] Rendering View [login], sessionId=B40B9A768D1713BE0145798470A1F985.jvm1

2010-03-05 11:16:53,982 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.022s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-05 11:16:53,995 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.011s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-05 11:16:54,030 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.03s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-05 11:16:54,034 (http-0.0.0.0-8443-3) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]

2010-03-05 11:16:54,396 (http-0.0.0.0-8443-3) [ ServiceDispatcher.java:586:INFO ] Sync service [partymgr/getVisualThemeResources] finished in [102] milliseconds

2010-03-05 11:16:55,192 (http-0.0.0.0-8443-3) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [ServerHitBin]; curSeqId=11270, maxSeqId=11280, bankSize=10

2010-03-05 11:16:55,387 (http-0.0.0.0-8443-3) [ ControlServlet.java:312:INFO ] [[[Preferences] Request Done- total:2.149,since last([Preferences] Req...):2.149]]

2010-03-05 12:11:22,538 (default-invoker-Thread-8868) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-8868] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 12:11:22,567 (default-invoker-Thread-8868) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@66f71774[15074] -- Next runtime: Fri Mar 05 13:11:22 CET 2010

2010-03-05 12:11:22,613 (default-invoker-Thread-8868) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 12:11:22,660 (default-invoker-Thread-8868) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 12:11:22,660 (default-invoker-Thread-8868) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [84] milliseconds

2010-03-05 12:11:22,723 (default-invoker-Thread-8868) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [148] milliseconds

2010-03-05 12:17:39,983 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: B40B9A768D1713BE0145798470A1F985.jvm1

2010-03-05 13:11:24,638 (default-invoker-Thread-8866) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-8866] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 13:11:24,658 (default-invoker-Thread-8866) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@703a55e6[15075] -- Next runtime: Fri Mar 05 14:11:24 CET 2010

2010-03-05 13:11:24,706 (default-invoker-Thread-8866) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 13:11:24,718 (default-invoker-Thread-8866) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 13:11:24,718 (default-invoker-Thread-8866) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [51] milliseconds

2010-03-05 13:11:24,777 (default-invoker-Thread-8866) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [111] milliseconds

2010-03-05 14:11:27,482 (default-invoker-Thread-8867) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-8867] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 14:11:27,516 (default-invoker-Thread-8867) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@50bc03da[15076] -- Next runtime: Fri Mar 05 15:11:27 CET 2010

2010-03-05 14:11:27,562 (default-invoker-Thread-8867) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 14:11:27,574 (default-invoker-Thread-8867) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 14:11:27,635 (default-invoker-Thread-8867) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [111] milliseconds

2010-03-05 15:11:29,633 (default-invoker-Thread-9857) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-9857] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 15:11:29,666 (default-invoker-Thread-9857) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@234918b0[15077] -- Next runtime: Fri Mar 05 16:11:29 CET 2010

2010-03-05 15:11:29,709 (default-invoker-Thread-9857) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 15:11:29,720 (default-invoker-Thread-9857) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 15:11:29,778 (default-invoker-Thread-9857) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [105] milliseconds

2010-03-05 16:11:32,441 (default-invoker-Thread-9858) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-9858] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 16:11:32,466 (default-invoker-Thread-9858) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@11f8852a[15078] -- Next runtime: Fri Mar 05 17:11:32 CET 2010

2010-03-05 16:11:32,512 (default-invoker-Thread-9858) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 16:11:32,523 (default-invoker-Thread-9858) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 16:11:32,582 (default-invoker-Thread-9858) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-05 17:11:34,534 (default-invoker-Thread-9857) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-9857] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 17:11:34,565 (default-invoker-Thread-9857) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4373de0f[15079] -- Next runtime: Fri Mar 05 18:11:34 CET 2010

2010-03-05 17:11:34,609 (default-invoker-Thread-9857) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 17:11:34,620 (default-invoker-Thread-9857) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 17:11:34,678 (default-invoker-Thread-9857) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [105] milliseconds

2010-03-05 18:11:36,617 (default-invoker-Thread-9857) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-9857] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 18:11:36,638 (default-invoker-Thread-9857) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1af4bada[15080] -- Next runtime: Fri Mar 05 19:11:36 CET 2010

2010-03-05 18:11:36,683 (default-invoker-Thread-9857) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 18:11:36,694 (default-invoker-Thread-9857) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 18:11:36,752 (default-invoker-Thread-9857) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-05 19:11:39,472 (default-invoker-Thread-9858) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-9858] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 19:11:39,506 (default-invoker-Thread-9858) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7108e18e[15081] -- Next runtime: Fri Mar 05 20:11:39 CET 2010

2010-03-05 19:11:39,552 (default-invoker-Thread-9858) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 19:11:39,563 (default-invoker-Thread-9858) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 19:11:39,621 (default-invoker-Thread-9858) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [105] milliseconds

2010-03-05 20:11:41,569 (default-invoker-Thread-10829) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10829] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 20:11:41,592 (default-invoker-Thread-10829) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7bc5f70c[15082] -- Next runtime: Fri Mar 05 21:11:41 CET 2010

2010-03-05 20:11:41,637 (default-invoker-Thread-10829) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 20:11:41,648 (default-invoker-Thread-10829) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 20:11:41,706 (default-invoker-Thread-10829) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-05 21:11:44,409 (default-invoker-Thread-10827) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10827] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 21:11:44,436 (default-invoker-Thread-10827) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4564325b[15083] -- Next runtime: Fri Mar 05 22:11:44 CET 2010

2010-03-05 21:11:44,481 (default-invoker-Thread-10827) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 21:11:44,492 (default-invoker-Thread-10827) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 21:11:44,550 (default-invoker-Thread-10827) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-05 22:11:46,492 (default-invoker-Thread-10828) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10828] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 22:11:46,525 (default-invoker-Thread-10828) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1f1b4edb[15084] -- Next runtime: Fri Mar 05 23:11:46 CET 2010

2010-03-05 22:11:46,570 (default-invoker-Thread-10828) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 22:11:46,581 (default-invoker-Thread-10828) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 22:11:46,639 (default-invoker-Thread-10828) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-05 22:58:34,029 (http-0.0.0.0-8443-2) [ControlEventListener.java:63 :INFO ] Creating session: 22BDB903E47D433939A6FEFE4F8494F2.jvm1

2010-03-05 22:58:34,030 (http-0.0.0.0-8443-2) [ ControlServlet.java:134:INFO ] [[[Preferences] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-05 22:58:34,030 (http-0.0.0.0-8443-2) [ VisitHandler.java:221:INFO ] Found visitorId [10000] in cookie

2010-03-05 22:58:34,081 (http-0.0.0.0-8443-2) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-05 22:58:34,084 (http-0.0.0.0-8443-2) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-05 22:58:34,107 (http-0.0.0.0-8443-2) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0080s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-05 22:58:34,113 (http-0.0.0.0-8443-2) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.038s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-05 22:58:34,119 (http-0.0.0.0-8443-2) [ RequestHandler.java:716:INFO ] Rendering View [login], sessionId=22BDB903E47D433939A6FEFE4F8494F2.jvm1

2010-03-05 22:58:34,198 (http-0.0.0.0-8443-2) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.011s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-05 22:58:34,207 (http-0.0.0.0-8443-2) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-05 22:58:34,219 (http-0.0.0.0-8443-2) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-05 22:58:34,223 (http-0.0.0.0-8443-2) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]

2010-03-05 22:58:34,436 (http-0.0.0.0-8443-2) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [ServerHitBin]; curSeqId=11280, maxSeqId=11290, bankSize=10

2010-03-05 22:58:34,439 (http-0.0.0.0-8443-2) [ ControlServlet.java:312:INFO ] [[[Preferences] Request Done- total:0.409,since last([Preferences] Req...):0.409]]

2010-03-05 22:58:47,600 (http-0.0.0.0-8443-6) [ ControlServlet.java:134:INFO ] [[[login] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-05 22:58:47,619 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-05 22:58:47,622 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-05 22:58:47,645 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0080s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-05 22:58:47,651 (http-0.0.0.0-8443-6) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.038s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-05 22:58:47,865 (http-0.0.0.0-8443-6) [ ServiceDispatcher.java:586:INFO ] Sync service [partymgr/userLogin] finished in [197] milliseconds

2010-03-05 22:58:48,022 (http-0.0.0.0-8443-6) [ LoginWorker.java:558:INFO ] Running autoLogin check.

2010-03-05 22:58:48,026 (http-0.0.0.0-8443-6) [ RequestHandler.java:612:INFO ] Ran Event [java:org.ofbiz.webapp.control.LoginWorker#login] from [request], result is [success]

2010-03-05 22:58:48,092 (http-0.0.0.0-8443-6) [ RequestHandler.java:460:INFO ] [Doing Previous Request]: /Preferences sessionId=22BDB903E47D433939A6FEFE4F8494F2.jvm1

2010-03-05 22:58:48,093 (http-0.0.0.0-8443-6) [ RequestHandler.java:672:INFO ] Sending redirect to: [/partymgr/control/Preferences?partyId=BLOG_EDITOR], sessionId=22BDB903E47D433939A6FEFE4F8494F2.jvm1

2010-03-05 22:58:48,113 (http-0.0.0.0-8443-6) [ ControlServlet.java:312:INFO ] [[[login] Request Done- total:0.512,since last([login] Request B...):0.512]]

2010-03-05 22:58:48,415 (http-0.0.0.0-8443-2) [ ControlServlet.java:134:INFO ] [[[Preferences] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-05 22:58:48,471 (http-0.0.0.0-8443-2) [ RequestHandler.java:716:INFO ] Rendering View [Preferences], sessionId=22BDB903E47D433939A6FEFE4F8494F2.jvm1

2010-03-05 22:58:48,546 (http-0.0.0.0-8443-2) [ ScreenFactory.java:129:INFO ] Got 32 screens in 0.036s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/PartyScreens.xml

2010-03-05 22:58:48,635 (http-0.0.0.0-8443-2) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.0090s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-05 22:58:48,720 (http-0.0.0.0-8443-2) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-05 22:58:48,852 (http-0.0.0.0-8443-2) [ ServiceDispatcher.java:586:INFO ] Sync service [partymgr/getLastSystemInfoNote] finished in [98] milliseconds

2010-03-05 22:58:48,875 (http-0.0.0.0-8443-2) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-05 22:58:49,427 (http-0.0.0.0-8443-2) [ ControlServlet.java:312:INFO ] [[[Preferences] Request Done- total:1.012,since last([Preferences] Req...):1.012]]

2010-03-05 23:11:49,350 (default-invoker-Thread-10830) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10830] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-05 23:11:49,399 (default-invoker-Thread-10830) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@35f91dcb[15085] -- Next runtime: Sat Mar 06 00:11:49 CET 2010

2010-03-05 23:11:49,439 (default-invoker-Thread-10830) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-05 23:11:49,443 (default-invoker-Thread-10830) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-05 23:11:49,504 (default-invoker-Thread-10830) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [101] milliseconds

2010-03-05 23:59:44,935 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: 22BDB903E47D433939A6FEFE4F8494F2.jvm1

2010-03-06 00:00:11,311 (default-invoker-Thread-10826) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10826] received job [Create Also Bought Product Associations] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:00:11,312 (default-invoker-Thread-10827) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10827] received job [Clear EntitySyncRemove Info] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:00:11,313 (default-invoker-Thread-10829) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10829] received job [Re-Try Failed Auths NSF] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:00:11,314 (default-invoker-Thread-10830) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10830] received job [Re-Try Failed Auths] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:00:11,315 (default-invoker-Thread-10828) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10828] received job [Purge Old Jobs] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:00:11,388 (default-invoker-Thread-10829) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2909b556[15060] -- Next runtime: Sun Mar 07 00:00:00 CET 2010

2010-03-06 00:00:11,411 (default-invoker-Thread-10827) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3aa3fc1b[15061] -- Next runtime: Sun Mar 07 00:00:00 CET 2010

2010-03-06 00:00:11,411 (default-invoker-Thread-10826) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@63fc6eb0[15062] -- Next runtime: Sun Mar 07 00:00:00 CET 2010

2010-03-06 00:00:11,411 (default-invoker-Thread-10828) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@51c71818[15058] -- Next runtime: Sun Mar 07 00:00:00 CET 2010

2010-03-06 00:00:11,411 (default-invoker-Thread-10830) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@68304b5d[15059] -- Next runtime: Sun Mar 07 00:00:00 CET 2010

2010-03-06 00:00:11,415 (default-invoker-Thread-10827) [ EntitySyncServices.java:600:INFO ] Running cleanSyncRemoveInfo

2010-03-06 00:00:11,435 (default-invoker-Thread-10828) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-06 00:00:11,507 (default-invoker-Thread-10826) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createAlsoBoughtProductAssocs] finished in [92] milliseconds

2010-03-06 00:00:11,571 (default-invoker-Thread-10827) [ EntitySyncServices.java:627:INFO ] In cleanSyncRemoveInfo removed [1] values with TX timestamp before [2010-03-05 23:36:11.509]

2010-03-06 00:00:11,573 (default-invoker-Thread-10826) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10826] received job [Extend expired Subscriptions] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:00:11,577 (default-invoker-Thread-10827) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/cleanSyncRemoveInfo] finished in [163] milliseconds

2010-03-06 00:00:11,600 (default-invoker-Thread-10827) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10827] received job [Cancels all orders after date] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:00:11,605 (default-invoker-Thread-10829) [PaymentGatewayServices.java:2660:INFO ] Processing failed order re-auth(s)

2010-03-06 00:00:11,605 (default-invoker-Thread-10829) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/retryFailedAuthNsfs] finished in [208] milliseconds

2010-03-06 00:00:11,610 (default-invoker-Thread-10830) [PaymentGatewayServices.java:2611:INFO ] Processing failed order re-auth(s)

2010-03-06 00:00:11,611 (default-invoker-Thread-10830) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/retryFailedAuths] finished in [193] milliseconds

2010-03-06 00:00:11,612 (default-invoker-Thread-10826) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@77e678b2[15057] -- Next runtime: Sun Mar 07 00:00:00 CET 2010

2010-03-06 00:00:11,640 (default-invoker-Thread-10830) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10830] received job [Purge Old Store Auto-Entered Promos] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:00:11,670 (default-invoker-Thread-10827) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2bc3d198[15054] -- Next runtime: Sun Mar 07 00:00:00 CET 2010

2010-03-06 00:00:11,670 (default-invoker-Thread-10829) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10829] received job [Run Auto-Reorders] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:00:11,763 (default-invoker-Thread-10830) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3f55cecd[15052] -- Next runtime: Sun Mar 07 00:00:00 CET 2010

2010-03-06 00:00:11,775 (default-invoker-Thread-10826) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/runSubscriptionAutoReorders] finished in [160] milliseconds

2010-03-06 00:00:11,800 (default-invoker-Thread-10829) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@28246b96[15056] -- Next runtime: Sun Mar 07 00:00:00 CET 2010

2010-03-06 00:00:11,833 (default-invoker-Thread-10826) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10826] received job [BackOrder Notification] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:00:11,952 (default-invoker-Thread-10830) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/purgeOldStoreAutoPromos] finished in [167] milliseconds

2010-03-06 00:00:12,055 (default-invoker-Thread-10829) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/runShoppingListAutoReorder] finished in [101] milliseconds

2010-03-06 00:00:12,069 (default-invoker-Thread-10830) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10830] received job [Replacement Held Order Auto-Cancel] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:00:12,119 (default-invoker-Thread-10826) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5f811177[15055] -- Next runtime: Sun Mar 07 00:00:00 CET 2010

2010-03-06 00:00:12,121 (default-invoker-Thread-10830) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4030ba07[15053] -- Next runtime: Sun Mar 07 00:00:00 CET 2010

2010-03-06 00:00:12,304 (default-invoker-Thread-10826) [ InventoryServices.java:380:INFO ] OOS Inventory Items: 0

2010-03-06 00:00:12,305 (default-invoker-Thread-10826) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/checkInventoryAvailability] finished in [132] milliseconds

2010-03-06 00:00:12,335 (default-invoker-Thread-10827) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/cancelAllBackOrders] finished in [555] milliseconds

2010-03-06 00:00:12,494 (default-invoker-Thread-10830) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/autoCancelReplacementOrders] finished in [299] milliseconds

2010-03-06 00:00:12,555 (default-invoker-Thread-10828) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [EntitySyncRemove]; curSeqId=14480, maxSeqId=14490, bankSize=10

2010-03-06 00:00:13,136 (default-invoker-Thread-10828) [ GenericDelegator.java:1129:ERROR] ---- exception report ---------------------------------------------------------- Failure in removeByCondition operation for entity [RuntimeData]: org.ofbiz.entity.GenericDataSourceException: Generic Entity Exception occured in deleteByCondition (SQL Exception while executing the following:DELETE FROM OFBIZ.RUNTIME_DATA WHERE (RUNTIME_DATA_ID = '8501') (DELETE on table 'RUNTIME_DATA' caused a violation of foreign key constraint 'JOB_SNDBX_RNTMDTA' for key (8501). The statement has been rolled back.)). Rolling back transaction. Exception: org.ofbiz.entity.GenericDataSourceException Message: Generic Entity Exception occured in deleteByCondition (SQL Exception while executing the following:DELETE FROM OFBIZ.RUNTIME_DATA WHERE (RUNTIME_DATA_ID = '8501') (DELETE on table 'RUNTIME_DATA' caused a violation of foreign key constraint 'JOB_SNDBX_RNTMDTA' for key (8501). The statement has been rolled back.)) ---- cause --------------------------------------------------------------------- Exception: org.ofbiz.entity.GenericDataSourceException Message: SQL Exception while executing the following:DELETE FROM OFBIZ.RUNTIME_DATA WHERE (RUNTIME_DATA_ID = '8501') (DELETE on table 'RUNTIME_DATA' caused a violation of foreign key constraint 'JOB_SNDBX_RNTMDTA' for key (8501). The statement has been rolled back.) ---- cause --------------------------------------------------------------------- Exception: java.sql.SQLIntegrityConstraintViolationException Message: DELETE on table 'RUNTIME_DATA' caused a violation of foreign key constraint 'JOB_SNDBX_RNTMDTA' for key (8501). The statement has been rolled back. ---- cause --------------------------------------------------------------------- Exception: org.apache.derby.impl.jdbc.EmbedSQLException Message: DELETE on table 'RUNTIME_DATA' caused a violation of foreign key constraint 'JOB_SNDBX_RNTMDTA' for key (8501). The statement has been rolled back. ---- cause --------------------------------------------------------------------- Exception: org.apache.derby.iapi.error.StandardException Message: DELETE on table 'RUNTIME_DATA' caused a violation of foreign key constraint 'JOB_SNDBX_RNTMDTA' for key (8501). The statement has been rolled back. ---- stack trace --------------------------------------------------------------- ERROR 23503: DELETE on table 'RUNTIME_DATA' caused a violation of foreign key constraint 'JOB_SNDBX_RNTMDTA' for key (8501). The statement has been rolled back. org.apache.derby.iapi.error.StandardException.newException(Unknown Source) org.apache.derby.impl.sql.execute.ReferencedKeyRIChecker.doCheck(Unknown Source) org.apache.derby.impl.sql.execute.RISetChecker.doPKCheck(Unknown Source) org.apache.derby.impl.sql.execute.DeleteResultSet.collectAffectedRows(Unknown Source) org.apache.derby.impl.sql.execute.DeleteResultSet.open(Unknown Source) org.apache.derby.impl.sql.GenericPreparedStatement.execute(Unknown Source) org.apache.derby.impl.jdbc.EmbedStatement.executeStatement(Unknown Source) org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeStatement(Unknown Source) org.apache.derby.impl.jdbc.EmbedPreparedStatement.executeUpdate(Unknown Source) org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:102) org.apache.commons.dbcp.DelegatingPreparedStatement.executeUpdate(DelegatingPreparedStatement.java:102) org.ofbiz.entity.jdbc.SQLProcessor.executeUpdate(SQLProcessor.java:410) org.ofbiz.entity.datasource.GenericDAO.deleteByCondition(GenericDAO.java:1161) org.ofbiz.entity.datasource.GenericDAO.deleteByCondition(GenericDAO.java:1135) org.ofbiz.entity.datasource.GenericHelperDAO.removeByCondition(GenericHelperDAO.java:161) org.ofbiz.entity.GenericDelegator.removeByCondition(GenericDelegator.java:1118) org.ofbiz.entity.GenericDelegator.removeByAnd(GenericDelegator.java:1086) org.ofbiz.entity.GenericDelegator.removeByAnd(GenericDelegator.java:1071) org.ofbiz.entity.GenericDelegator.removeByAnd(GenericDelegator.java:1064) org.ofbiz.service.ServiceUtil.purgeOldJobs(ServiceUtil.java:473) sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) java.lang.reflect.Method.invoke(Method.java:597) org.ofbiz.service.engine.StandardJavaEngine.serviceInvoker(StandardJavaEngine.java:100) org.ofbiz.service.engine.StandardJavaEngine.runSync(StandardJavaEngine.java:57) org.ofbiz.service.ModelServiceReader$GenericInvokerImpl.runSync(ModelServiceReader.java:785) _$gen.file_58$.var.www.sitios.ofbiz.framework.service.servicedef.services_46$xml_35$purgeOldJobs.runSync(file:/var/www/sitios/ofbiz/framework/service/servicedef/services.xml#purgeOldJobs:29) org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:392) org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:221) org.ofbiz.service.GenericDispatcher.runSync(GenericDispatcher.java:159) org.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) org.ofbiz.service.job.JobInvoker.run(JobInvoker.java:242) java.lang.Thread.run(Thread.java:619) --------------------------------------------------------------------------------

2010-03-06 00:00:13,137 (default-invoker-Thread-10828) [ TransactionUtil.java:371:WARN ] ---- exception report ---------------------------------------------------------- [TransactionUtil.setRollbackOnly] Calling transaction setRollbackOnly; this stack trace shows where this is happening: Exception: java.lang.Exception Message: Failure in removeByCondition operation for entity [RuntimeData]: org.ofbiz.entity.GenericDataSourceException: Generic Entity Exception occured in deleteByCondition (SQL Exception while executing the following:DELETE FROM OFBIZ.RUNTIME_DATA WHERE (RUNTIME_DATA_ID = '8501') (DELETE on table 'RUNTIME_DATA' caused a violation of foreign key constraint 'JOB_SNDBX_RNTMDTA' for key (8501). The statement has been rolled back.)). Rolling back transaction. ---- stack trace --------------------------------------------------------------- java.lang.Exception: Failure in removeByCondition operation for entity [RuntimeData]: org.ofbiz.entity.GenericDataSourceException: Generic Entity Exception occured in deleteByCondition (SQL Exception while executing the following:DELETE FROM OFBIZ.RUNTIME_DATA WHERE (RUNTIME_DATA_ID = '8501') (DELETE on table 'RUNTIME_DATA' caused a violation of foreign key constraint 'JOB_SNDBX_RNTMDTA' for key (8501). The statement has been rolled back.)). Rolling back transaction. org.ofbiz.entity.transaction.TransactionUtil.setRollbackOnly(TransactionUtil.java:371) org.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:318) org.ofbiz.entity.GenericDelegator.removeByCondition(GenericDelegator.java:1132) org.ofbiz.entity.GenericDelegator.removeByAnd(GenericDelegator.java:1086) org.ofbiz.entity.GenericDelegator.removeByAnd(GenericDelegator.java:1071) org.ofbiz.entity.GenericDelegator.removeByAnd(GenericDelegator.java:1064) org.ofbiz.service.ServiceUtil.purgeOldJobs(ServiceUtil.java:473) sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) java.lang.reflect.Method.invoke(Method.java:597) org.ofbiz.service.engine.StandardJavaEngine.serviceInvoker(StandardJavaEngine.java:100) org.ofbiz.service.engine.StandardJavaEngine.runSync(StandardJavaEngine.java:57) org.ofbiz.service.ModelServiceReader$GenericInvokerImpl.runSync(ModelServiceReader.java:785) _$gen.file_58$.var.www.sitios.ofbiz.framework.service.servicedef.services_46$xml_35$purgeOldJobs.runSync(file:/var/www/sitios/ofbiz/framework/service/servicedef/services.xml#purgeOldJobs:29) org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:392) org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:221) org.ofbiz.service.GenericDispatcher.runSync(GenericDispatcher.java:159) org.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) org.ofbiz.service.job.JobInvoker.run(JobInvoker.java:242) java.lang.Thread.run(Thread.java:619) --------------------------------------------------------------------------------

2010-03-06 00:00:13,165 (default-invoker-Thread-10828) [ ServiceUtil.java:476:INFO ] Cannot remove runtime data for ID: 8501

2010-03-06 00:00:13,165 (default-invoker-Thread-10828) [ TransactionUtil.java:335:ERROR] ---- exception report ---------------------------------------------------------- [TransactionUtil.rollback] Exception: java.lang.Exception Message: Stack Trace ---- stack trace --------------------------------------------------------------- java.lang.Exception: Stack Trace org.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:334) org.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:316) org.ofbiz.service.ServiceUtil.purgeOldJobs(ServiceUtil.java:478) sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39) sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25) java.lang.reflect.Method.invoke(Method.java:597) org.ofbiz.service.engine.StandardJavaEngine.serviceInvoker(StandardJavaEngine.java:100) org.ofbiz.service.engine.StandardJavaEngine.runSync(StandardJavaEngine.java:57) org.ofbiz.service.ModelServiceReader$GenericInvokerImpl.runSync(ModelServiceReader.java:785) _$gen.file_58$.var.www.sitios.ofbiz.framework.service.servicedef.services_46$xml_35$purgeOldJobs.runSync(file:/var/www/sitios/ofbiz/framework/service/servicedef/services.xml#purgeOldJobs:29) org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:392) org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:221) org.ofbiz.service.GenericDispatcher.runSync(GenericDispatcher.java:159) org.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:70) org.ofbiz.service.job.JobInvoker.run(JobInvoker.java:242) java.lang.Thread.run(Thread.java:619) --------------------------------------------------------------------------------

2010-03-06 00:00:13,165 (default-invoker-Thread-10828) [ TransactionUtil.java:345:INFO ] [TransactionUtil.rollback] transaction rolled back

2010-03-06 00:00:13,166 (default-invoker-Thread-10828) [ TransactionUtil.java:268:WARN ] [TransactionUtil.commit] Not committing transaction, status is No Transaction (6)

2010-03-06 00:00:13,179 (default-invoker-Thread-10828) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-06 00:00:13,237 (default-invoker-Thread-10828) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/purgeOldJobs] finished in [1784] milliseconds

2010-03-06 00:11:51,188 (default-invoker-Thread-10827) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-10827] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 00:11:51,209 (default-invoker-Thread-10827) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@35d70cd7[15086] -- Next runtime: Sat Mar 06 01:11:51 CET 2010

2010-03-06 00:11:51,247 (default-invoker-Thread-10827) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 00:11:51,252 (default-invoker-Thread-10827) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 00:11:51,328 (default-invoker-Thread-10827) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [117] milliseconds

2010-03-06 01:11:53,559 (default-invoker-Thread-11995) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-11995] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 01:11:53,582 (default-invoker-Thread-11995) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@32e5c205[15098] -- Next runtime: Sat Mar 06 02:11:53 CET 2010

2010-03-06 01:11:53,628 (default-invoker-Thread-11995) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 01:11:53,640 (default-invoker-Thread-11995) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 01:11:53,700 (default-invoker-Thread-11995) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [110] milliseconds

2010-03-06 02:11:56,402 (default-invoker-Thread-11995) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-11995] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 02:11:56,429 (default-invoker-Thread-11995) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [JobSandbox]; curSeqId=15100, maxSeqId=15200, bankSize=100

2010-03-06 02:11:56,448 (default-invoker-Thread-11995) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7be9d0a3[15099] -- Next runtime: Sat Mar 06 03:11:56 CET 2010

2010-03-06 02:11:56,491 (default-invoker-Thread-11995) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 02:11:56,503 (default-invoker-Thread-11995) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 02:11:56,562 (default-invoker-Thread-11995) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-06 03:11:58,556 (default-invoker-Thread-11997) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-11997] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 03:11:58,612 (default-invoker-Thread-11997) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@56fc40e0[15100] -- Next runtime: Sat Mar 06 04:11:58 CET 2010

2010-03-06 03:11:58,656 (default-invoker-Thread-11997) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 03:11:58,667 (default-invoker-Thread-11997) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 03:11:58,727 (default-invoker-Thread-11997) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-06 04:12:02,171 (default-invoker-Thread-11996) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-11996] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 04:12:02,199 (default-invoker-Thread-11996) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@29e2eaea[15101] -- Next runtime: Sat Mar 06 05:12:02 CET 2010

2010-03-06 04:12:02,380 (default-invoker-Thread-11996) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 04:12:02,391 (default-invoker-Thread-11996) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 04:12:02,392 (default-invoker-Thread-11996) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [185] milliseconds

2010-03-06 04:12:02,471 (default-invoker-Thread-11996) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [264] milliseconds

2010-03-06 05:12:04,269 (default-invoker-Thread-11995) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-11995] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 05:12:04,301 (default-invoker-Thread-11995) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5a3a89ab[15102] -- Next runtime: Sat Mar 06 06:12:04 CET 2010

2010-03-06 05:12:04,346 (default-invoker-Thread-11995) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 05:12:04,357 (default-invoker-Thread-11995) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 05:12:04,416 (default-invoker-Thread-11995) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-06 06:12:06,355 (default-invoker-Thread-12967) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-12967] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 06:12:06,376 (default-invoker-Thread-12967) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@100f38f7[15103] -- Next runtime: Sat Mar 06 07:12:06 CET 2010

2010-03-06 06:12:06,420 (default-invoker-Thread-12967) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 06:12:06,431 (default-invoker-Thread-12967) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 06:12:06,491 (default-invoker-Thread-12967) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-06 07:12:09,239 (default-invoker-Thread-12964) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-12964] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 07:12:09,267 (default-invoker-Thread-12964) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4d3b8443[15104] -- Next runtime: Sat Mar 06 08:12:09 CET 2010

2010-03-06 07:12:09,311 (default-invoker-Thread-12964) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 07:12:09,322 (default-invoker-Thread-12964) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 07:12:09,382 (default-invoker-Thread-12964) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-06 08:12:11,328 (default-invoker-Thread-12964) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-12964] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 08:12:11,357 (default-invoker-Thread-12964) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@289a40bd[15105] -- Next runtime: Sat Mar 06 09:12:11 CET 2010

2010-03-06 08:12:11,401 (default-invoker-Thread-12964) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 08:12:11,412 (default-invoker-Thread-12964) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 08:12:11,473 (default-invoker-Thread-12964) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-06 09:12:14,168 (default-invoker-Thread-12968) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-12968] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 09:12:14,193 (default-invoker-Thread-12968) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@42dabc2c[15106] -- Next runtime: Sat Mar 06 10:12:14 CET 2010

2010-03-06 09:12:14,238 (default-invoker-Thread-12968) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 09:12:14,249 (default-invoker-Thread-12968) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 09:12:14,313 (default-invoker-Thread-12968) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [112] milliseconds

2010-03-06 10:12:16,272 (default-invoker-Thread-12966) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-12966] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 10:12:16,303 (default-invoker-Thread-12966) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7fd23da6[15107] -- Next runtime: Sat Mar 06 11:12:16 CET 2010

2010-03-06 10:12:16,349 (default-invoker-Thread-12966) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 10:12:16,360 (default-invoker-Thread-12966) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 10:12:16,419 (default-invoker-Thread-12966) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-06 11:12:18,363 (default-invoker-Thread-13936) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-13936] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 11:12:18,385 (default-invoker-Thread-13936) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4fc316e3[15108] -- Next runtime: Sat Mar 06 12:12:18 CET 2010

2010-03-06 11:12:18,430 (default-invoker-Thread-13936) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 11:12:18,441 (default-invoker-Thread-13936) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 11:12:18,501 (default-invoker-Thread-13936) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-06 12:12:21,149 (default-invoker-Thread-13934) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-13934] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 12:12:21,179 (default-invoker-Thread-13934) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@13f7928[15109] -- Next runtime: Sat Mar 06 13:12:21 CET 2010

2010-03-06 12:12:21,223 (default-invoker-Thread-13934) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 12:12:21,234 (default-invoker-Thread-13934) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 12:12:21,294 (default-invoker-Thread-13934) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-06 13:12:23,281 (default-invoker-Thread-13934) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-13934] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 13:12:23,321 (default-invoker-Thread-13934) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@dfc7491[15110] -- Next runtime: Sat Mar 06 14:12:23 CET 2010

2010-03-06 13:12:23,365 (default-invoker-Thread-13934) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 13:12:23,376 (default-invoker-Thread-13934) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 13:12:23,436 (default-invoker-Thread-13934) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-06 14:12:25,553 (default-invoker-Thread-13933) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-13933] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 14:12:25,573 (default-invoker-Thread-13933) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@10a6c7d8[15111] -- Next runtime: Sat Mar 06 15:12:25 CET 2010

2010-03-06 14:12:25,617 (default-invoker-Thread-13933) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 14:12:25,628 (default-invoker-Thread-13933) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 14:12:25,687 (default-invoker-Thread-13933) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-06 15:12:28,269 (default-invoker-Thread-13933) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-13933] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 15:12:28,300 (default-invoker-Thread-13933) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4307cf2[15112] -- Next runtime: Sat Mar 06 16:12:28 CET 2010

2010-03-06 15:12:28,344 (default-invoker-Thread-13933) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 15:12:28,355 (default-invoker-Thread-13933) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 15:12:28,419 (default-invoker-Thread-13933) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [111] milliseconds

2010-03-06 15:19:35,444 (http-0.0.0.0-8443-2) [ControlEventListener.java:63 :INFO ] Creating session: 958242E40690DDB6F7129BCFFF350C0E.jvm1

2010-03-06 15:19:35,444 (http-0.0.0.0-8443-2) [ ControlServlet.java:134:INFO ] [[[Preferences] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-06 15:19:35,445 (http-0.0.0.0-8443-2) [ VisitHandler.java:221:INFO ] Found visitorId [10000] in cookie

2010-03-06 15:19:35,761 (http-0.0.0.0-8443-2) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-06 15:19:35,782 (http-0.0.0.0-8443-2) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-06 15:19:35,805 (http-0.0.0.0-8443-2) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0080s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-06 15:19:35,812 (http-0.0.0.0-8443-2) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.056s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-06 15:19:35,814 (http-0.0.0.0-8443-2) [ RequestHandler.java:716:INFO ] Rendering View [login], sessionId=958242E40690DDB6F7129BCFFF350C0E.jvm1

2010-03-06 15:19:35,886 (http-0.0.0.0-8443-2) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.028s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-06 15:19:35,896 (http-0.0.0.0-8443-2) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-06 15:19:35,912 (http-0.0.0.0-8443-2) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.013s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-06 15:19:35,916 (http-0.0.0.0-8443-2) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]

2010-03-06 15:19:36,187 (http-0.0.0.0-8443-2) [ ServiceDispatcher.java:586:INFO ] Sync service [partymgr/getVisualThemeResources] finished in [91] milliseconds

2010-03-06 15:19:36,558 (http-0.0.0.0-8443-2) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [ServerHitBin]; curSeqId=11290, maxSeqId=11300, bankSize=10

2010-03-06 15:19:36,563 (http-0.0.0.0-8443-2) [ ControlServlet.java:312:INFO ] [[[Preferences] Request Done- total:1.118,since last([Preferences] Req...):1.118]]

2010-03-06 16:12:30,374 (default-invoker-Thread-14927) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-14927] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 16:12:30,421 (default-invoker-Thread-14927) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7a96d9c5[15113] -- Next runtime: Sat Mar 06 17:12:30 CET 2010

2010-03-06 16:12:30,504 (default-invoker-Thread-14927) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 16:12:30,554 (default-invoker-Thread-14927) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 16:12:30,555 (default-invoker-Thread-14927) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [86] milliseconds

2010-03-06 16:12:30,746 (default-invoker-Thread-14927) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [278] milliseconds

2010-03-06 16:19:54,598 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: 958242E40690DDB6F7129BCFFF350C0E.jvm1

2010-03-06 17:12:33,216 (default-invoker-Thread-14926) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-14926] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 17:12:33,238 (default-invoker-Thread-14926) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@43187d55[15114] -- Next runtime: Sat Mar 06 18:12:33 CET 2010

2010-03-06 17:12:33,282 (default-invoker-Thread-14926) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 17:12:33,293 (default-invoker-Thread-14926) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 17:12:33,352 (default-invoker-Thread-14926) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-06 18:03:54,983 (http-0.0.0.0-8443-3) [ControlEventListener.java:63 :INFO ] Creating session: 1849F8702615ED43742650E335F499F5.jvm1

2010-03-06 18:03:54,984 (http-0.0.0.0-8443-3) [ ControlServlet.java:134:INFO ] [[[findPayments] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-06 18:03:54,984 (http-0.0.0.0-8443-3) [ VisitHandler.java:221:INFO ] Found visitorId [10301] in cookie

2010-03-06 18:03:55,040 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-06 18:03:55,044 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-06 18:03:55,054 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.02s, 473 requests, 228 views in jndi:/0.0.0.0/accounting/WEB-INF/controller.xml

2010-03-06 18:03:55,057 (http-0.0.0.0-8443-3) [ RequestHandler.java:716:INFO ] Rendering View [login], sessionId=1849F8702615ED43742650E335F499F5.jvm1

2010-03-06 18:03:55,110 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-06 18:03:55,130 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 11 screens in 0.019s from: file:/var/www/sitios/ofbiz/applications/accounting/widget/CommonScreens.xml

2010-03-06 18:03:55,155 (http-0.0.0.0-8443-3) [ UtilProperties.java:875:INFO ] ResourceBundle AccountingHelpUrls (es) created in 0.022s with 0 properties

2010-03-06 18:03:55,164 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-06 18:03:55,168 (http-0.0.0.0-8443-3) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]

2010-03-06 18:03:55,382 (http-0.0.0.0-8443-3) [ ControlServlet.java:312:INFO ] [[[findPayments] Request Done- total:0.397,since last([findPayments] Re...):0.398]]

2010-03-06 18:12:35,303 (default-invoker-Thread-14924) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-14924] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 18:12:35,334 (default-invoker-Thread-14924) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5d3d1f6f[15115] -- Next runtime: Sat Mar 06 19:12:35 CET 2010

2010-03-06 18:12:35,378 (default-invoker-Thread-14924) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 18:12:35,390 (default-invoker-Thread-14924) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 18:12:35,469 (default-invoker-Thread-14924) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [127] milliseconds

2010-03-06 19:03:56,365 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: 1849F8702615ED43742650E335F499F5.jvm1

2010-03-06 19:12:38,211 (default-invoker-Thread-14924) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-14924] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 19:12:38,234 (default-invoker-Thread-14924) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@796fb09d[15116] -- Next runtime: Sat Mar 06 20:12:38 CET 2010

2010-03-06 19:12:38,279 (default-invoker-Thread-14924) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 19:12:38,290 (default-invoker-Thread-14924) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 19:12:38,349 (default-invoker-Thread-14924) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-06 20:12:40,303 (default-invoker-Thread-14927) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-14927] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 20:12:40,328 (default-invoker-Thread-14927) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4d11e01f[15117] -- Next runtime: Sat Mar 06 21:12:40 CET 2010

2010-03-06 20:12:40,373 (default-invoker-Thread-14927) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 20:12:40,384 (default-invoker-Thread-14927) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 20:12:40,443 (default-invoker-Thread-14927) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-06 21:12:42,394 (default-invoker-Thread-15914) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15914] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 21:12:42,415 (default-invoker-Thread-15914) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7f892596[15118] -- Next runtime: Sat Mar 06 22:12:42 CET 2010

2010-03-06 21:12:42,460 (default-invoker-Thread-15914) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 21:12:42,471 (default-invoker-Thread-15914) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 21:12:42,532 (default-invoker-Thread-15914) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [109] milliseconds

2010-03-06 22:12:45,236 (default-invoker-Thread-15913) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15913] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 22:12:45,290 (default-invoker-Thread-15913) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@22b14af9[15119] -- Next runtime: Sat Mar 06 23:12:45 CET 2010

2010-03-06 22:12:45,335 (default-invoker-Thread-15913) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 22:12:45,346 (default-invoker-Thread-15913) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 22:12:45,405 (default-invoker-Thread-15913) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-06 23:12:47,366 (default-invoker-Thread-15915) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15915] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-06 23:12:47,393 (default-invoker-Thread-15915) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4ccce62c[15120] -- Next runtime: Sun Mar 07 00:12:47 CET 2010

2010-03-06 23:12:47,438 (default-invoker-Thread-15915) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-06 23:12:47,449 (default-invoker-Thread-15915) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-06 23:12:47,509 (default-invoker-Thread-15915) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [109] milliseconds

2010-03-07 00:00:09,143 (default-invoker-Thread-15913) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15913] received job [BackOrder Notification] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:00:09,143 (default-invoker-Thread-15916) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15916] received job [Purge Old Store Auto-Entered Promos] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:00:09,143 (default-invoker-Thread-15914) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15914] received job [Run Auto-Reorders] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:00:09,143 (default-invoker-Thread-15915) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15915] received job [Replacement Held Order Auto-Cancel] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:00:09,145 (default-invoker-Thread-15917) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15917] received job [Cancels all orders after date] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:00:09,175 (default-invoker-Thread-15915) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5a8fcdc9[15097] -- Next runtime: Mon Mar 08 00:00:00 CET 2010

2010-03-07 00:00:09,183 (default-invoker-Thread-15917) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1c323438[15093] -- Next runtime: Mon Mar 08 00:00:00 CET 2010

2010-03-07 00:00:09,191 (default-invoker-Thread-15916) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@18203d94[15094] -- Next runtime: Mon Mar 08 00:00:00 CET 2010

2010-03-07 00:00:09,191 (default-invoker-Thread-15914) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6caacbeb[15095] -- Next runtime: Mon Mar 08 00:00:00 CET 2010

2010-03-07 00:00:09,192 (default-invoker-Thread-15913) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4131e909[15096] -- Next runtime: Mon Mar 08 00:00:00 CET 2010

2010-03-07 00:00:09,364 (default-invoker-Thread-15915) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/autoCancelReplacementOrders] finished in [172] milliseconds

2010-03-07 00:00:09,367 (default-invoker-Thread-15916) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/purgeOldStoreAutoPromos] finished in [172] milliseconds

2010-03-07 00:00:09,391 (default-invoker-Thread-15915) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15915] received job [Extend expired Subscriptions] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:00:09,391 (default-invoker-Thread-15916) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15916] received job [Clear EntitySyncRemove Info] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:00:09,413 (default-invoker-Thread-15914) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/runShoppingListAutoReorder] finished in [217] milliseconds

2010-03-07 00:00:09,429 (default-invoker-Thread-15916) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2bdb282d[15088] -- Next runtime: Mon Mar 08 00:00:00 CET 2010

2010-03-07 00:00:09,429 (default-invoker-Thread-15915) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@412ab8d9[15092] -- Next runtime: Mon Mar 08 00:00:00 CET 2010

2010-03-07 00:00:09,433 (default-invoker-Thread-15916) [ EntitySyncServices.java:600:INFO ] Running cleanSyncRemoveInfo

2010-03-07 00:00:09,457 (default-invoker-Thread-15914) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15914] received job [Re-Try Failed Auths] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:00:09,501 (default-invoker-Thread-15913) [ InventoryServices.java:380:INFO ] OOS Inventory Items: 0

2010-03-07 00:00:09,502 (default-invoker-Thread-15913) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/checkInventoryAvailability] finished in [306] milliseconds

2010-03-07 00:00:09,507 (default-invoker-Thread-15913) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15913] received job [Purge Old Jobs] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:00:09,535 (default-invoker-Thread-15916) [ EntitySyncServices.java:627:INFO ] In cleanSyncRemoveInfo removed [14] values with TX timestamp before [2010-03-06 23:36:09.504]

2010-03-07 00:00:09,537 (default-invoker-Thread-15914) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@271e2ae5[15089] -- Next runtime: Mon Mar 08 00:00:00 CET 2010

2010-03-07 00:00:09,538 (default-invoker-Thread-15913) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2d923473[15087] -- Next runtime: Mon Mar 08 00:00:00 CET 2010

2010-03-07 00:00:09,538 (default-invoker-Thread-15916) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/cleanSyncRemoveInfo] finished in [106] milliseconds

2010-03-07 00:00:09,570 (default-invoker-Thread-15916) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15916] received job [Create Also Bought Product Associations] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:00:09,595 (default-invoker-Thread-15916) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4e01d51f[15090] -- Next runtime: Mon Mar 08 00:00:00 CET 2010

2010-03-07 00:00:09,599 (default-invoker-Thread-15917) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/cancelAllBackOrders] finished in [397] milliseconds

2010-03-07 00:00:09,636 (default-invoker-Thread-15915) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/runSubscriptionAutoReorders] finished in [204] milliseconds

2010-03-07 00:00:09,691 (default-invoker-Thread-15914) [PaymentGatewayServices.java:2611:INFO ] Processing failed order re-auth(s)

2010-03-07 00:00:09,691 (default-invoker-Thread-15914) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/retryFailedAuths] finished in [110] milliseconds

2010-03-07 00:00:09,695 (default-invoker-Thread-15917) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15917] received job [Re-Try Failed Auths NSF] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:00:09,696 (default-invoker-Thread-15913) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-07 00:00:09,715 (default-invoker-Thread-15917) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@57769a2a[15091] -- Next runtime: Mon Mar 08 00:00:00 CET 2010

2010-03-07 00:00:09,730 (default-invoker-Thread-15917) [PaymentGatewayServices.java:2660:INFO ] Processing failed order re-auth(s)

2010-03-07 00:00:09,730 (default-invoker-Thread-15916) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createAlsoBoughtProductAssocs] finished in [132] milliseconds

2010-03-07 00:00:09,741 (default-invoker-Thread-15913) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-07 00:00:09,771 (default-invoker-Thread-15913) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/purgeOldJobs] finished in [56] milliseconds

2010-03-07 00:12:50,026 (default-invoker-Thread-15915) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15915] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 00:12:50,041 (default-invoker-Thread-15915) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4e60138d[15121] -- Next runtime: Sun Mar 07 01:12:50 CET 2010

2010-03-07 00:12:50,080 (default-invoker-Thread-15915) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 00:12:50,085 (default-invoker-Thread-15915) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 00:12:50,148 (default-invoker-Thread-15915) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [104] milliseconds

2010-03-07 01:12:52,314 (default-invoker-Thread-15914) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-15914] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 01:12:52,343 (default-invoker-Thread-15914) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@ef7ba83[15133] -- Next runtime: Sun Mar 07 02:12:52 CET 2010

2010-03-07 01:12:52,388 (default-invoker-Thread-15914) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 01:12:52,398 (default-invoker-Thread-15914) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 01:12:52,458 (default-invoker-Thread-15914) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-07 02:12:55,150 (default-invoker-Thread-16991) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-16991] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 02:12:55,180 (default-invoker-Thread-16991) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@dbce38f[15134] -- Next runtime: Sun Mar 07 03:12:55 CET 2010

2010-03-07 02:12:55,224 (default-invoker-Thread-16991) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 02:12:55,235 (default-invoker-Thread-16991) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 02:12:55,294 (default-invoker-Thread-16991) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-07 03:12:57,290 (default-invoker-Thread-16993) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-16993] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 03:12:57,322 (default-invoker-Thread-16993) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7836397b[15135] -- Next runtime: Sun Mar 07 04:12:57 CET 2010

2010-03-07 03:12:57,367 (default-invoker-Thread-16993) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 03:12:57,378 (default-invoker-Thread-16993) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 03:12:57,437 (default-invoker-Thread-16993) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-07 04:12:59,379 (default-invoker-Thread-16992) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-16992] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 04:12:59,400 (default-invoker-Thread-16992) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5c21c349[15136] -- Next runtime: Sun Mar 07 05:12:59 CET 2010

2010-03-07 04:12:59,446 (default-invoker-Thread-16992) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 04:12:59,457 (default-invoker-Thread-16992) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 04:12:59,516 (default-invoker-Thread-16992) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-07 05:13:02,224 (default-invoker-Thread-16991) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-16991] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 05:13:02,253 (default-invoker-Thread-16991) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3bcdffda[15137] -- Next runtime: Sun Mar 07 06:13:02 CET 2010

2010-03-07 05:13:02,296 (default-invoker-Thread-16991) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 05:13:02,307 (default-invoker-Thread-16991) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 05:13:02,366 (default-invoker-Thread-16991) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-07 06:13:04,314 (default-invoker-Thread-16994) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-16994] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 06:13:04,338 (default-invoker-Thread-16994) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7c7c1645[15138] -- Next runtime: Sun Mar 07 07:13:04 CET 2010

2010-03-07 06:13:04,382 (default-invoker-Thread-16994) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 06:13:04,393 (default-invoker-Thread-16994) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 06:13:04,453 (default-invoker-Thread-16994) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-07 07:13:06,420 (default-invoker-Thread-17961) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-17961] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 07:13:06,442 (default-invoker-Thread-17961) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5589c87d[15139] -- Next runtime: Sun Mar 07 08:13:06 CET 2010

2010-03-07 07:13:06,487 (default-invoker-Thread-17961) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 07:13:06,497 (default-invoker-Thread-17961) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 07:13:06,556 (default-invoker-Thread-17961) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-07 08:13:09,259 (default-invoker-Thread-17961) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-17961] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 08:13:09,287 (default-invoker-Thread-17961) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@79f8db52[15140] -- Next runtime: Sun Mar 07 09:13:09 CET 2010

2010-03-07 08:13:09,331 (default-invoker-Thread-17961) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 08:13:09,342 (default-invoker-Thread-17961) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 08:13:09,402 (default-invoker-Thread-17961) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-07 09:13:11,353 (default-invoker-Thread-17960) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-17960] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 09:13:11,384 (default-invoker-Thread-17960) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@faf1047[15141] -- Next runtime: Sun Mar 07 10:13:11 CET 2010

2010-03-07 09:13:11,429 (default-invoker-Thread-17960) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 09:13:11,440 (default-invoker-Thread-17960) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 09:13:11,499 (default-invoker-Thread-17960) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-07 10:13:14,198 (default-invoker-Thread-17963) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-17963] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 10:13:14,230 (default-invoker-Thread-17963) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5c01999c[15142] -- Next runtime: Sun Mar 07 11:13:14 CET 2010

2010-03-07 10:13:14,274 (default-invoker-Thread-17963) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 10:13:14,285 (default-invoker-Thread-17963) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 10:13:14,345 (default-invoker-Thread-17963) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-07 11:13:16,296 (default-invoker-Thread-17959) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-17959] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 11:13:16,326 (default-invoker-Thread-17959) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3365cebf[15143] -- Next runtime: Sun Mar 07 12:13:16 CET 2010

2010-03-07 11:13:16,371 (default-invoker-Thread-17959) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 11:13:16,382 (default-invoker-Thread-17959) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 11:13:16,441 (default-invoker-Thread-17959) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-07 12:13:18,385 (default-invoker-Thread-18929) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-18929] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 12:13:18,405 (default-invoker-Thread-18929) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@171962c0[15144] -- Next runtime: Sun Mar 07 13:13:18 CET 2010

2010-03-07 12:13:18,449 (default-invoker-Thread-18929) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 12:13:18,460 (default-invoker-Thread-18929) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 12:13:18,519 (default-invoker-Thread-18929) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-07 13:13:21,225 (default-invoker-Thread-18929) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-18929] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 13:13:21,256 (default-invoker-Thread-18929) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@15cbb21b[15145] -- Next runtime: Sun Mar 07 14:13:21 CET 2010

2010-03-07 13:13:21,301 (default-invoker-Thread-18929) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 13:13:21,312 (default-invoker-Thread-18929) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 13:13:21,371 (default-invoker-Thread-18929) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-07 14:13:23,330 (default-invoker-Thread-18931) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-18931] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 14:13:23,359 (default-invoker-Thread-18931) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@47019306[15146] -- Next runtime: Sun Mar 07 15:13:23 CET 2010

2010-03-07 14:13:23,404 (default-invoker-Thread-18931) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 14:13:23,415 (default-invoker-Thread-18931) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 14:13:23,476 (default-invoker-Thread-18931) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [109] milliseconds

2010-03-07 15:13:26,195 (default-invoker-Thread-18929) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-18929] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 15:13:26,219 (default-invoker-Thread-18929) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1c301f7b[15147] -- Next runtime: Sun Mar 07 16:13:26 CET 2010

2010-03-07 15:13:26,263 (default-invoker-Thread-18929) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 15:13:26,273 (default-invoker-Thread-18929) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 15:13:26,333 (default-invoker-Thread-18929) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-07 16:13:28,284 (default-invoker-Thread-18931) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-18931] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 16:13:28,318 (default-invoker-Thread-18931) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@222fb315[15148] -- Next runtime: Sun Mar 07 17:13:28 CET 2010

2010-03-07 16:13:28,363 (default-invoker-Thread-18931) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 16:13:28,373 (default-invoker-Thread-18931) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 16:13:28,433 (default-invoker-Thread-18931) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-07 17:13:30,381 (default-invoker-Thread-19901) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-19901] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 17:13:30,409 (default-invoker-Thread-19901) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5247ed4d[15149] -- Next runtime: Sun Mar 07 18:13:30 CET 2010

2010-03-07 17:13:30,453 (default-invoker-Thread-19901) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 17:13:30,464 (default-invoker-Thread-19901) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 17:13:30,524 (default-invoker-Thread-19901) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-07 18:13:33,223 (default-invoker-Thread-19902) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-19902] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 18:13:33,246 (default-invoker-Thread-19902) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@72d3182a[15150] -- Next runtime: Sun Mar 07 19:13:33 CET 2010

2010-03-07 18:13:33,290 (default-invoker-Thread-19902) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 18:13:33,301 (default-invoker-Thread-19902) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 18:13:33,361 (default-invoker-Thread-19902) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-07 19:13:35,321 (default-invoker-Thread-19901) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-19901] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 19:13:35,350 (default-invoker-Thread-19901) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@61253e8f[15151] -- Next runtime: Sun Mar 07 20:13:35 CET 2010

2010-03-07 19:13:35,395 (default-invoker-Thread-19901) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 19:13:35,406 (default-invoker-Thread-19901) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 19:13:35,466 (default-invoker-Thread-19901) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-07 20:13:38,163 (default-invoker-Thread-19899) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-19899] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 20:13:38,192 (default-invoker-Thread-19899) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@416100b0[15152] -- Next runtime: Sun Mar 07 21:13:38 CET 2010

2010-03-07 20:13:38,237 (default-invoker-Thread-19899) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 20:13:38,247 (default-invoker-Thread-19899) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 20:13:38,307 (default-invoker-Thread-19899) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-07 21:13:40,252 (default-invoker-Thread-19900) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-19900] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 21:13:40,282 (default-invoker-Thread-19900) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@488b1fe0[15153] -- Next runtime: Sun Mar 07 22:13:40 CET 2010

2010-03-07 21:13:40,327 (default-invoker-Thread-19900) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 21:13:40,338 (default-invoker-Thread-19900) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 21:13:40,398 (default-invoker-Thread-19900) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-07 22:13:42,341 (default-invoker-Thread-20871) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20871] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 22:13:42,361 (default-invoker-Thread-20871) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2e304447[15154] -- Next runtime: Sun Mar 07 23:13:42 CET 2010

2010-03-07 22:13:42,406 (default-invoker-Thread-20871) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 22:13:42,416 (default-invoker-Thread-20871) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 22:13:42,476 (default-invoker-Thread-20871) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-07 23:13:45,201 (default-invoker-Thread-20869) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20869] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-07 23:13:45,231 (default-invoker-Thread-20869) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2742882c[15155] -- Next runtime: Mon Mar 08 00:13:45 CET 2010

2010-03-07 23:13:45,275 (default-invoker-Thread-20869) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-07 23:13:45,286 (default-invoker-Thread-20869) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-07 23:13:45,346 (default-invoker-Thread-20869) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-08 00:00:06,820 (default-invoker-Thread-20868) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20868] received job [Purge Old Jobs] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:00:06,820 (default-invoker-Thread-20871) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20871] received job [Re-Try Failed Auths] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:00:06,820 (default-invoker-Thread-20870) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20870] received job [Create Also Bought Product Associations] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:00:06,820 (default-invoker-Thread-20869) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20869] received job [Re-Try Failed Auths NSF] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:00:06,863 (default-invoker-Thread-20867) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20867] received job [Extend expired Subscriptions] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:00:06,873 (default-invoker-Thread-20868) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@45331545[15130] -- Next runtime: Tue Mar 09 00:00:00 CET 2010

2010-03-08 00:00:06,886 (default-invoker-Thread-20868) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-08 00:00:06,888 (default-invoker-Thread-20869) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@fb05698[15132] -- Next runtime: Tue Mar 09 00:00:00 CET 2010

2010-03-08 00:00:06,888 (default-invoker-Thread-20867) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2051d34[15128] -- Next runtime: Tue Mar 09 00:00:00 CET 2010

2010-03-08 00:00:06,890 (default-invoker-Thread-20871) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4a81249a[15129] -- Next runtime: Tue Mar 09 00:00:00 CET 2010

2010-03-08 00:00:06,890 (default-invoker-Thread-20870) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@648a20ac[15131] -- Next runtime: Tue Mar 09 00:00:00 CET 2010

2010-03-08 00:00:06,901 (default-invoker-Thread-20869) [PaymentGatewayServices.java:2660:INFO ] Processing failed order re-auth(s)

2010-03-08 00:00:06,926 (default-invoker-Thread-20869) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20869] received job [Clear EntitySyncRemove Info] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:00:06,930 (default-invoker-Thread-20871) [PaymentGatewayServices.java:2611:INFO ] Processing failed order re-auth(s)

2010-03-08 00:00:06,936 (default-invoker-Thread-20871) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20871] received job [Cancels all orders after date] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:00:06,937 (default-invoker-Thread-20867) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20867] received job [Purge Old Store Auto-Entered Promos] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:00:06,937 (default-invoker-Thread-20869) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1547816d[15127] -- Next runtime: Tue Mar 09 00:00:00 CET 2010

2010-03-08 00:00:06,942 (default-invoker-Thread-20869) [ EntitySyncServices.java:600:INFO ] Running cleanSyncRemoveInfo

2010-03-08 00:00:06,943 (default-invoker-Thread-20871) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6e76a82c[15126] -- Next runtime: Tue Mar 09 00:00:00 CET 2010

2010-03-08 00:00:06,943 (default-invoker-Thread-20867) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@411fa9b5[15125] -- Next runtime: Tue Mar 09 00:00:00 CET 2010

2010-03-08 00:00:06,954 (default-invoker-Thread-20869) [ EntitySyncServices.java:627:INFO ] In cleanSyncRemoveInfo removed [1] values with TX timestamp before [2010-03-07 23:36:06.948]

2010-03-08 00:00:06,977 (default-invoker-Thread-20870) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20870] received job [BackOrder Notification] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:00:06,977 (default-invoker-Thread-20867) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20867] received job [Replacement Held Order Auto-Cancel] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:00:06,992 (default-invoker-Thread-20870) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6d7488ea[15123] -- Next runtime: Tue Mar 09 00:00:00 CET 2010

2010-03-08 00:00:06,992 (default-invoker-Thread-20867) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@13bbaaa3[15122] -- Next runtime: Tue Mar 09 00:00:00 CET 2010

2010-03-08 00:00:06,992 (default-invoker-Thread-20869) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20869] received job [Run Auto-Reorders] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:00:07,013 (default-invoker-Thread-20871) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/cancelAllBackOrders] finished in [67] milliseconds

2010-03-08 00:00:07,021 (default-invoker-Thread-20870) [ InventoryServices.java:380:INFO ] OOS Inventory Items: 0

2010-03-08 00:00:07,033 (default-invoker-Thread-20869) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7339a2f2[15124] -- Next runtime: Tue Mar 09 00:00:00 CET 2010

2010-03-08 00:00:07,066 (default-invoker-Thread-20868) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [EntitySyncRemove]; curSeqId=14490, maxSeqId=14500, bankSize=10

2010-03-08 00:00:07,177 (default-invoker-Thread-20868) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [EntitySyncRemove]; curSeqId=14500, maxSeqId=14510, bankSize=10

2010-03-08 00:00:07,283 (default-invoker-Thread-20868) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-08 00:00:07,298 (default-invoker-Thread-20868) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/purgeOldJobs] finished in [399] milliseconds

2010-03-08 00:13:47,506 (default-invoker-Thread-20867) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20867] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 00:13:47,518 (default-invoker-Thread-20867) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@43f82496[15156] -- Next runtime: Mon Mar 08 01:13:47 CET 2010

2010-03-08 00:13:47,557 (default-invoker-Thread-20867) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 00:13:47,597 (default-invoker-Thread-20867) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 00:13:47,597 (default-invoker-Thread-20867) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [75] milliseconds

2010-03-08 00:13:47,659 (default-invoker-Thread-20867) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [138] milliseconds

2010-03-08 01:13:50,154 (default-invoker-Thread-20871) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20871] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 01:13:50,186 (default-invoker-Thread-20871) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1375b1ec[15168] -- Next runtime: Mon Mar 08 02:13:50 CET 2010

2010-03-08 01:13:50,231 (default-invoker-Thread-20871) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 01:13:50,243 (default-invoker-Thread-20871) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 01:13:50,302 (default-invoker-Thread-20871) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-08 02:13:52,242 (default-invoker-Thread-20868) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-20868] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 02:13:52,270 (default-invoker-Thread-20868) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@27b5c161[15169] -- Next runtime: Mon Mar 08 03:13:52 CET 2010

2010-03-08 02:13:52,315 (default-invoker-Thread-20868) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 02:13:52,325 (default-invoker-Thread-20868) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 02:13:52,385 (default-invoker-Thread-20868) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-08 03:13:54,383 (default-invoker-Thread-21978) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-21978] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 03:13:54,405 (default-invoker-Thread-21978) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@759b8d22[15170] -- Next runtime: Mon Mar 08 04:13:54 CET 2010

2010-03-08 03:13:54,450 (default-invoker-Thread-21978) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 03:13:54,461 (default-invoker-Thread-21978) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 03:13:54,520 (default-invoker-Thread-21978) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-08 04:13:57,228 (default-invoker-Thread-21981) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-21981] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 04:13:57,250 (default-invoker-Thread-21981) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@165cb2c9[15171] -- Next runtime: Mon Mar 08 05:13:57 CET 2010

2010-03-08 04:13:57,295 (default-invoker-Thread-21981) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 04:13:57,306 (default-invoker-Thread-21981) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 04:13:57,364 (default-invoker-Thread-21981) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-08 05:14:00,078 (default-invoker-Thread-21979) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-21979] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 05:14:00,110 (default-invoker-Thread-21979) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7388291b[15172] -- Next runtime: Mon Mar 08 06:14:00 CET 2010

2010-03-08 05:14:00,155 (default-invoker-Thread-21979) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 05:14:00,166 (default-invoker-Thread-21979) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 05:14:00,227 (default-invoker-Thread-21979) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [110] milliseconds

2010-03-08 06:14:02,919 (default-invoker-Thread-21981) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-21981] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 06:14:02,953 (default-invoker-Thread-21981) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1bb15144[15173] -- Next runtime: Mon Mar 08 07:14:02 CET 2010

2010-03-08 06:14:02,998 (default-invoker-Thread-21981) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 06:14:03,009 (default-invoker-Thread-21981) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 06:14:03,068 (default-invoker-Thread-21981) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-08 07:14:05,032 (default-invoker-Thread-21979) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-21979] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 07:14:05,063 (default-invoker-Thread-21979) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@70f4795d[15174] -- Next runtime: Mon Mar 08 08:14:05 CET 2010

2010-03-08 07:14:05,108 (default-invoker-Thread-21979) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 07:14:05,118 (default-invoker-Thread-21979) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 07:14:05,177 (default-invoker-Thread-21979) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-08 08:14:07,122 (default-invoker-Thread-22946) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-22946] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 08:14:07,144 (default-invoker-Thread-22946) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1d6bee05[15175] -- Next runtime: Mon Mar 08 09:14:07 CET 2010

2010-03-08 08:14:07,188 (default-invoker-Thread-22946) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 08:14:07,199 (default-invoker-Thread-22946) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 08:14:07,258 (default-invoker-Thread-22946) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-08 09:14:10,020 (default-invoker-Thread-22947) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-22947] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 09:14:10,050 (default-invoker-Thread-22947) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6b63ce8a[15176] -- Next runtime: Mon Mar 08 10:14:10 CET 2010

2010-03-08 09:14:10,094 (default-invoker-Thread-22947) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 09:14:10,105 (default-invoker-Thread-22947) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 09:14:10,165 (default-invoker-Thread-22947) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-08 10:14:12,138 (default-invoker-Thread-22946) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-22946] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 10:14:12,173 (default-invoker-Thread-22946) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7851f33c[15177] -- Next runtime: Mon Mar 08 11:14:12 CET 2010

2010-03-08 10:14:12,220 (default-invoker-Thread-22946) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 10:14:12,231 (default-invoker-Thread-22946) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 10:14:12,292 (default-invoker-Thread-22946) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [111] milliseconds

2010-03-08 10:43:56,731 (http-0.0.0.0-8443-3) [ControlEventListener.java:63 :INFO ] Creating session: 9963DB29D2B9F663A1EB90990F396001.jvm1

2010-03-08 10:43:56,732 (http-0.0.0.0-8443-3) [ ControlServlet.java:134:INFO ] [[[Preferences] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-08 10:43:56,732 (http-0.0.0.0-8443-3) [ VisitHandler.java:221:INFO ] Found visitorId [10000] in cookie

2010-03-08 10:43:56,785 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-08 10:43:56,789 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-08 10:43:56,812 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0090s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-08 10:43:56,818 (http-0.0.0.0-8443-3) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.038s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-08 10:43:56,820 (http-0.0.0.0-8443-3) [ RequestHandler.java:716:INFO ] Rendering View [login], sessionId=9963DB29D2B9F663A1EB90990F396001.jvm1

2010-03-08 10:43:56,930 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-08 10:43:56,941 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.01s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-08 10:43:56,953 (http-0.0.0.0-8443-3) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-08 10:43:56,957 (http-0.0.0.0-8443-3) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]

2010-03-08 10:43:57,159 (http-0.0.0.0-8443-3) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [ServerHitBin]; curSeqId=11300, maxSeqId=11310, bankSize=10

2010-03-08 10:43:57,186 (http-0.0.0.0-8443-3) [ ControlServlet.java:312:INFO ] [[[Preferences] Request Done- total:0.454,since last([Preferences] Req...):0.454]]

2010-03-08 11:14:15,025 (default-invoker-Thread-22947) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-22947] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 11:14:15,058 (default-invoker-Thread-22947) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4a101331[15178] -- Next runtime: Mon Mar 08 12:14:15 CET 2010

2010-03-08 11:14:15,103 (default-invoker-Thread-22947) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 11:14:15,117 (default-invoker-Thread-22947) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 11:14:15,117 (default-invoker-Thread-22947) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [51] milliseconds

2010-03-08 11:14:15,181 (default-invoker-Thread-22947) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [115] milliseconds

2010-03-08 11:45:20,447 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: 9963DB29D2B9F663A1EB90990F396001.jvm1

2010-03-08 12:14:17,104 (default-invoker-Thread-22947) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-22947] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 12:14:17,136 (default-invoker-Thread-22947) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3bec388a[15179] -- Next runtime: Mon Mar 08 13:14:17 CET 2010

2010-03-08 12:14:17,180 (default-invoker-Thread-22947) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 12:14:17,191 (default-invoker-Thread-22947) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 12:14:17,251 (default-invoker-Thread-22947) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-08 13:14:19,220 (default-invoker-Thread-23942) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-23942] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 13:14:19,242 (default-invoker-Thread-23942) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1fd0c08[15180] -- Next runtime: Mon Mar 08 14:14:19 CET 2010

2010-03-08 13:14:19,288 (default-invoker-Thread-23942) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 13:14:19,299 (default-invoker-Thread-23942) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 13:14:19,362 (default-invoker-Thread-23942) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [111] milliseconds

2010-03-08 14:14:22,075 (default-invoker-Thread-23943) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-23943] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 14:14:22,110 (default-invoker-Thread-23943) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6afca09a[15181] -- Next runtime: Mon Mar 08 15:14:22 CET 2010

2010-03-08 14:14:22,157 (default-invoker-Thread-23943) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 14:14:22,169 (default-invoker-Thread-23943) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 14:14:22,169 (default-invoker-Thread-23943) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [51] milliseconds

2010-03-08 14:14:22,232 (default-invoker-Thread-23943) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [115] milliseconds

2010-03-08 15:14:24,187 (default-invoker-Thread-23941) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-23941] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 15:14:24,228 (default-invoker-Thread-23941) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@60c9b0ed[15182] -- Next runtime: Mon Mar 08 16:14:24 CET 2010

2010-03-08 15:14:24,275 (default-invoker-Thread-23941) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 15:14:24,287 (default-invoker-Thread-23941) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 15:14:24,288 (default-invoker-Thread-23941) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [51] milliseconds

2010-03-08 15:14:24,348 (default-invoker-Thread-23941) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [112] milliseconds

2010-03-08 16:14:27,051 (default-invoker-Thread-23941) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-23941] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 16:14:27,099 (default-invoker-Thread-23941) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@f8c6f4c[15183] -- Next runtime: Mon Mar 08 17:14:27 CET 2010

2010-03-08 16:14:27,143 (default-invoker-Thread-23941) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 16:14:27,154 (default-invoker-Thread-23941) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 16:14:27,213 (default-invoker-Thread-23941) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-08 17:14:29,135 (default-invoker-Thread-23944) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-23944] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 17:14:29,167 (default-invoker-Thread-23944) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2bc21906[15184] -- Next runtime: Mon Mar 08 18:14:29 CET 2010

2010-03-08 17:14:29,212 (default-invoker-Thread-23944) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 17:14:29,224 (default-invoker-Thread-23944) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 17:14:29,284 (default-invoker-Thread-23944) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [109] milliseconds

2010-03-08 18:14:31,251 (default-invoker-Thread-24914) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-24914] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 18:14:31,275 (default-invoker-Thread-24914) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7f32ea26[15185] -- Next runtime: Mon Mar 08 19:14:31 CET 2010

2010-03-08 18:14:31,326 (default-invoker-Thread-24914) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 18:14:31,339 (default-invoker-Thread-24914) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 18:14:31,339 (default-invoker-Thread-24914) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [54] milliseconds

2010-03-08 18:14:31,401 (default-invoker-Thread-24914) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [117] milliseconds

2010-03-08 19:14:34,118 (default-invoker-Thread-24910) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-24910] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 19:14:34,140 (default-invoker-Thread-24910) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@462025ca[15186] -- Next runtime: Mon Mar 08 20:14:34 CET 2010

2010-03-08 19:14:34,184 (default-invoker-Thread-24910) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 19:14:34,194 (default-invoker-Thread-24910) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 19:14:34,255 (default-invoker-Thread-24910) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-08 20:14:36,213 (default-invoker-Thread-24914) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-24914] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 20:14:36,247 (default-invoker-Thread-24914) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5675c12d[15187] -- Next runtime: Mon Mar 08 21:14:36 CET 2010

2010-03-08 20:14:36,292 (default-invoker-Thread-24914) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 20:14:36,303 (default-invoker-Thread-24914) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 20:14:36,362 (default-invoker-Thread-24914) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-08 21:14:02,856 (http-0.0.0.0-8443-4) [ControlEventListener.java:63 :INFO ] Creating session: 4F30917ADFC1721ED9BB7C6A981B3F26.jvm1

2010-03-08 21:14:02,856 (http-0.0.0.0-8443-4) [ ControlServlet.java:134:INFO ] [[[Preferences] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-08 21:14:02,857 (http-0.0.0.0-8443-4) [ VisitHandler.java:221:INFO ] Found visitorId [10000] in cookie

2010-03-08 21:14:02,901 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-08 21:14:02,905 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-08 21:14:02,928 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0080s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-08 21:14:02,934 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.039s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-08 21:14:02,937 (http-0.0.0.0-8443-4) [ RequestHandler.java:716:INFO ] Rendering View [login], sessionId=4F30917ADFC1721ED9BB7C6A981B3F26.jvm1

2010-03-08 21:14:02,990 (http-0.0.0.0-8443-4) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-08 21:14:02,999 (http-0.0.0.0-8443-4) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-08 21:14:03,011 (http-0.0.0.0-8443-4) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-08 21:14:03,015 (http-0.0.0.0-8443-4) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]

2010-03-08 21:14:03,223 (http-0.0.0.0-8443-4) [ ControlServlet.java:312:INFO ] [[[Preferences] Request Done- total:0.367,since last([Preferences] Req...):0.367]]

2010-03-08 21:14:39,066 (default-invoker-Thread-24913) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-24913] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 21:14:39,094 (default-invoker-Thread-24913) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@12a851b6[15188] -- Next runtime: Mon Mar 08 22:14:39 CET 2010

2010-03-08 21:14:39,157 (default-invoker-Thread-24913) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 21:14:39,169 (default-invoker-Thread-24913) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 21:14:39,170 (default-invoker-Thread-24913) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [67] milliseconds

2010-03-08 21:14:39,232 (default-invoker-Thread-24913) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [129] milliseconds

2010-03-08 22:14:26,855 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: 4F30917ADFC1721ED9BB7C6A981B3F26.jvm1

2010-03-08 22:14:41,175 (default-invoker-Thread-24910) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-24910] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 22:14:41,200 (default-invoker-Thread-24910) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3c17bc10[15189] -- Next runtime: Mon Mar 08 23:14:41 CET 2010

2010-03-08 22:14:41,245 (default-invoker-Thread-24910) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 22:14:41,256 (default-invoker-Thread-24910) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 22:14:41,316 (default-invoker-Thread-24910) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-08 23:14:43,293 (default-invoker-Thread-25900) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25900] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-08 23:14:43,312 (default-invoker-Thread-25900) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@74812eb9[15190] -- Next runtime: Tue Mar 09 00:14:43 CET 2010

2010-03-08 23:14:43,356 (default-invoker-Thread-25900) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-08 23:14:43,367 (default-invoker-Thread-25900) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-08 23:14:43,426 (default-invoker-Thread-25900) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-09 00:00:05,495 (default-invoker-Thread-25903) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25903] received job [Run Auto-Reorders] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:00:05,496 (default-invoker-Thread-25900) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25900] received job [Purge Old Store Auto-Entered Promos] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:00:05,495 (default-invoker-Thread-25902) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25902] received job [BackOrder Notification] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:00:05,495 (default-invoker-Thread-25904) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25904] received job [Replacement Held Order Auto-Cancel] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:00:05,497 (default-invoker-Thread-25901) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25901] received job [Cancels all orders after date] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:00:05,530 (default-invoker-Thread-25904) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@27e4132c[15166] -- Next runtime: Wed Mar 10 00:00:00 CET 2010

2010-03-09 00:00:05,531 (default-invoker-Thread-25900) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6ea6c229[15164] -- Next runtime: Wed Mar 10 00:00:00 CET 2010

2010-03-09 00:00:05,536 (default-invoker-Thread-25903) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@1d897eb3[15167] -- Next runtime: Wed Mar 10 00:00:00 CET 2010

2010-03-09 00:00:05,552 (default-invoker-Thread-25901) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2aa73e4a[15163] -- Next runtime: Wed Mar 10 00:00:00 CET 2010

2010-03-09 00:00:05,552 (default-invoker-Thread-25902) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4306b2b3[15165] -- Next runtime: Wed Mar 10 00:00:00 CET 2010

2010-03-09 00:00:05,570 (default-invoker-Thread-25903) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25903] received job [Clear EntitySyncRemove Info] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:00:05,586 (default-invoker-Thread-25902) [ InventoryServices.java:380:INFO ] OOS Inventory Items: 0

2010-03-09 00:00:05,596 (default-invoker-Thread-25900) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25900] received job [Re-Try Failed Auths] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:00:05,598 (default-invoker-Thread-25902) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25902] received job [Extend expired Subscriptions] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:00:05,598 (default-invoker-Thread-25904) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25904] received job [Create Also Bought Product Associations] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:00:05,598 (default-invoker-Thread-25903) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3b9197f0[15162] -- Next runtime: Wed Mar 10 00:00:00 CET 2010

2010-03-09 00:00:05,602 (default-invoker-Thread-25903) [ EntitySyncServices.java:600:INFO ] Running cleanSyncRemoveInfo

2010-03-09 00:00:05,607 (default-invoker-Thread-25900) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4f5bc1f0[15161] -- Next runtime: Wed Mar 10 00:00:00 CET 2010

2010-03-09 00:00:05,609 (default-invoker-Thread-25902) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6405bb5f[15160] -- Next runtime: Wed Mar 10 00:00:00 CET 2010

2010-03-09 00:00:05,617 (default-invoker-Thread-25903) [ EntitySyncServices.java:627:INFO ] In cleanSyncRemoveInfo removed [18] values with TX timestamp before [2010-03-08 23:36:05.608]

2010-03-09 00:00:05,619 (default-invoker-Thread-25904) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [JobSandbox]; curSeqId=15200, maxSeqId=15300, bankSize=100

2010-03-09 00:00:05,622 (default-invoker-Thread-25900) [PaymentGatewayServices.java:2611:INFO ] Processing failed order re-auth(s)

2010-03-09 00:00:05,630 (default-invoker-Thread-25904) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@34851387[15159] -- Next runtime: Wed Mar 10 00:00:00 CET 2010

2010-03-09 00:00:05,631 (default-invoker-Thread-25902) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25902] received job [Re-Try Failed Auths NSF] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:00:05,632 (default-invoker-Thread-25903) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25903] received job [Purge Old Jobs] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:00:05,641 (default-invoker-Thread-25901) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/cancelAllBackOrders] finished in [65] milliseconds

2010-03-09 00:00:05,643 (default-invoker-Thread-25902) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5456b3fc[15158] -- Next runtime: Wed Mar 10 00:00:00 CET 2010

2010-03-09 00:00:05,643 (default-invoker-Thread-25903) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2749ed72[15157] -- Next runtime: Wed Mar 10 00:00:00 CET 2010

2010-03-09 00:00:05,656 (default-invoker-Thread-25903) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-09 00:00:05,658 (default-invoker-Thread-25902) [PaymentGatewayServices.java:2660:INFO ] Processing failed order re-auth(s)

2010-03-09 00:00:05,759 (default-invoker-Thread-25903) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [EntitySyncRemove]; curSeqId=14510, maxSeqId=14520, bankSize=10

2010-03-09 00:00:05,865 (default-invoker-Thread-25903) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [EntitySyncRemove]; curSeqId=14520, maxSeqId=14530, bankSize=10

2010-03-09 00:00:05,976 (default-invoker-Thread-25903) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [EntitySyncRemove]; curSeqId=14530, maxSeqId=14540, bankSize=10

2010-03-09 00:00:06,087 (default-invoker-Thread-25903) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [EntitySyncRemove]; curSeqId=14540, maxSeqId=14550, bankSize=10

2010-03-09 00:00:06,137 (default-invoker-Thread-25903) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-09 00:00:06,150 (default-invoker-Thread-25903) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/purgeOldJobs] finished in [489] milliseconds

2010-03-09 00:14:46,041 (default-invoker-Thread-25903) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25903] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 00:14:46,056 (default-invoker-Thread-25903) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4f78a3e2[15191] -- Next runtime: Tue Mar 09 01:14:46 CET 2010

2010-03-09 00:14:46,094 (default-invoker-Thread-25903) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 00:14:46,098 (default-invoker-Thread-25903) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 00:14:46,160 (default-invoker-Thread-25903) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [102] milliseconds

2010-03-09 01:14:48,254 (default-invoker-Thread-25903) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25903] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 01:14:48,276 (default-invoker-Thread-25903) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3632dddf[15203] -- Next runtime: Tue Mar 09 02:14:48 CET 2010

2010-03-09 01:14:48,321 (default-invoker-Thread-25903) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 01:14:48,332 (default-invoker-Thread-25903) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 01:14:48,392 (default-invoker-Thread-25903) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-09 02:14:51,098 (default-invoker-Thread-25904) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25904] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 02:14:51,126 (default-invoker-Thread-25904) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@a513d5[15204] -- Next runtime: Tue Mar 09 03:14:51 CET 2010

2010-03-09 02:14:51,171 (default-invoker-Thread-25904) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 02:14:51,182 (default-invoker-Thread-25904) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 02:14:51,241 (default-invoker-Thread-25904) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [106] milliseconds

2010-03-09 03:14:53,233 (default-invoker-Thread-25902) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-25902] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 03:14:53,256 (default-invoker-Thread-25902) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@30c7f619[15205] -- Next runtime: Tue Mar 09 04:14:53 CET 2010

2010-03-09 03:14:53,301 (default-invoker-Thread-25902) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 03:14:53,312 (default-invoker-Thread-25902) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 03:14:53,371 (default-invoker-Thread-25902) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-09 04:14:55,323 (default-invoker-Thread-27056) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-27056] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 04:14:55,342 (default-invoker-Thread-27056) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@425c085f[15206] -- Next runtime: Tue Mar 09 05:14:55 CET 2010

2010-03-09 04:14:55,386 (default-invoker-Thread-27056) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 04:14:55,397 (default-invoker-Thread-27056) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 04:14:55,456 (default-invoker-Thread-27056) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-09 05:14:58,168 (default-invoker-Thread-27057) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-27057] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 05:14:58,198 (default-invoker-Thread-27057) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4b7a89d9[15207] -- Next runtime: Tue Mar 09 06:14:58 CET 2010

2010-03-09 05:14:58,244 (default-invoker-Thread-27057) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 05:14:58,255 (default-invoker-Thread-27057) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 05:14:58,315 (default-invoker-Thread-27057) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [109] milliseconds

2010-03-09 06:15:00,266 (default-invoker-Thread-27056) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-27056] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 06:15:00,315 (default-invoker-Thread-27056) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@29fb870a[15208] -- Next runtime: Tue Mar 09 07:15:00 CET 2010

2010-03-09 06:15:00,359 (default-invoker-Thread-27056) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 06:15:00,370 (default-invoker-Thread-27056) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 06:15:00,429 (default-invoker-Thread-27056) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-09 07:15:03,127 (default-invoker-Thread-27054) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-27054] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 07:15:03,161 (default-invoker-Thread-27054) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5b5dfbd8[15209] -- Next runtime: Tue Mar 09 08:15:03 CET 2010

2010-03-09 07:15:03,206 (default-invoker-Thread-27054) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 07:15:03,217 (default-invoker-Thread-27054) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 07:15:03,278 (default-invoker-Thread-27054) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [109] milliseconds

2010-03-09 08:15:05,217 (default-invoker-Thread-27058) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-27058] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 08:15:05,248 (default-invoker-Thread-27058) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@37ce6ef8[15210] -- Next runtime: Tue Mar 09 09:15:05 CET 2010

2010-03-09 08:15:05,292 (default-invoker-Thread-27058) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 08:15:05,302 (default-invoker-Thread-27058) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 08:15:05,362 (default-invoker-Thread-27058) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-09 09:15:08,111 (default-invoker-Thread-28027) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-28027] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 09:15:08,145 (default-invoker-Thread-28027) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@324dd40a[15211] -- Next runtime: Tue Mar 09 10:15:08 CET 2010

2010-03-09 09:15:08,190 (default-invoker-Thread-28027) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 09:15:08,201 (default-invoker-Thread-28027) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 09:15:08,260 (default-invoker-Thread-28027) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-09 10:15:10,180 (default-invoker-Thread-28023) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-28023] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 10:15:10,202 (default-invoker-Thread-28023) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5a96d602[15212] -- Next runtime: Tue Mar 09 11:15:10 CET 2010

2010-03-09 10:15:10,247 (default-invoker-Thread-28023) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 10:15:10,258 (default-invoker-Thread-28023) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 10:15:10,317 (default-invoker-Thread-28023) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-09 10:28:33,590 (http-0.0.0.0-8443-9) [ControlEventListener.java:63 :INFO ] Creating session: 70A83E85489D73BDD3CEA27ECF0E1737.jvm1

2010-03-09 10:28:33,591 (http-0.0.0.0-8443-9) [ ControlServlet.java:134:INFO ] [[[Preferences] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-09 10:28:33,592 (http-0.0.0.0-8443-9) [ VisitHandler.java:221:INFO ] Found visitorId [10000] in cookie

2010-03-09 10:28:33,632 (http-0.0.0.0-8443-9) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-09 10:28:33,636 (http-0.0.0.0-8443-9) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-09 10:28:33,659 (http-0.0.0.0-8443-9) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0090s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-09 10:28:33,665 (http-0.0.0.0-8443-9) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.038s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-09 10:28:33,668 (http-0.0.0.0-8443-9) [ RequestHandler.java:716:INFO ] Rendering View [login], sessionId=70A83E85489D73BDD3CEA27ECF0E1737.jvm1

2010-03-09 10:28:33,739 (http-0.0.0.0-8443-9) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.027s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-09 10:28:33,750 (http-0.0.0.0-8443-9) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.01s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-09 10:28:33,762 (http-0.0.0.0-8443-9) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-09 10:28:33,767 (http-0.0.0.0-8443-9) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]

2010-03-09 10:28:33,945 (http-0.0.0.0-8443-9) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [ServerHitBin]; curSeqId=11310, maxSeqId=11320, bankSize=10

2010-03-09 10:28:33,976 (http-0.0.0.0-8443-9) [ ControlServlet.java:312:INFO ] [[[Preferences] Request Done- total:0.385,since last([Preferences] Req...):0.385]]

2010-03-09 11:15:13,086 (default-invoker-Thread-28024) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-28024] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 11:15:13,120 (default-invoker-Thread-28024) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4478bc8c[15213] -- Next runtime: Tue Mar 09 12:15:13 CET 2010

2010-03-09 11:15:13,166 (default-invoker-Thread-28024) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 11:15:13,179 (default-invoker-Thread-28024) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 11:15:13,244 (default-invoker-Thread-28024) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [115] milliseconds

2010-03-09 11:29:34,899 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: 70A83E85489D73BDD3CEA27ECF0E1737.jvm1

2010-03-09 12:15:15,267 (default-invoker-Thread-28026) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-28026] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 12:15:15,300 (default-invoker-Thread-28026) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6d51771f[15214] -- Next runtime: Tue Mar 09 13:15:15 CET 2010

2010-03-09 12:15:15,349 (default-invoker-Thread-28026) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 12:15:15,361 (default-invoker-Thread-28026) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 12:15:15,361 (default-invoker-Thread-28026) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [53] milliseconds

2010-03-09 12:15:15,426 (default-invoker-Thread-28026) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [118] milliseconds

2010-03-09 13:15:18,026 (default-invoker-Thread-28027) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-28027] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 13:15:18,064 (default-invoker-Thread-28027) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@369b43bd[15215] -- Next runtime: Tue Mar 09 14:15:18 CET 2010

2010-03-09 13:15:18,110 (default-invoker-Thread-28027) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 13:15:18,121 (default-invoker-Thread-28027) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 13:15:18,182 (default-invoker-Thread-28027) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [109] milliseconds

2010-03-09 14:15:20,300 (default-invoker-Thread-29017) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-29017] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 14:15:20,333 (default-invoker-Thread-29017) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@70a6ea22[15216] -- Next runtime: Tue Mar 09 15:15:20 CET 2010

2010-03-09 14:15:20,380 (default-invoker-Thread-29017) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 14:15:20,391 (default-invoker-Thread-29017) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 14:15:20,450 (default-invoker-Thread-29017) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [109] milliseconds

2010-03-09 15:15:23,142 (default-invoker-Thread-29018) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-29018] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 15:15:23,250 (default-invoker-Thread-29018) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@5d739633[15217] -- Next runtime: Tue Mar 09 16:15:23 CET 2010

2010-03-09 15:15:23,295 (default-invoker-Thread-29018) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 15:15:23,306 (default-invoker-Thread-29018) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 15:15:23,367 (default-invoker-Thread-29018) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [109] milliseconds

2010-03-09 16:15:25,992 (default-invoker-Thread-29017) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-29017] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 16:15:26,020 (default-invoker-Thread-29017) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@16252aaf[15218] -- Next runtime: Tue Mar 09 17:15:25 CET 2010

2010-03-09 16:15:26,064 (default-invoker-Thread-29017) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 16:15:26,076 (default-invoker-Thread-29017) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 16:15:26,139 (default-invoker-Thread-29017) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [111] milliseconds

2010-03-09 17:15:28,098 (default-invoker-Thread-29015) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-29015] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 17:15:28,119 (default-invoker-Thread-29015) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@772d5597[15219] -- Next runtime: Tue Mar 09 18:15:28 CET 2010

2010-03-09 17:15:28,163 (default-invoker-Thread-29015) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 17:15:28,174 (default-invoker-Thread-29015) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 17:15:28,234 (default-invoker-Thread-29015) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-09 18:11:30,086 (http-0.0.0.0-8443-4) [ControlEventListener.java:63 :INFO ] Creating session: DBA77007FAB03132F70108BBFEE78507.jvm1

2010-03-09 18:11:30,087 (http-0.0.0.0-8443-4) [ ControlServlet.java:134:INFO ] [[[Preferences] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-09 18:11:30,087 (http-0.0.0.0-8443-4) [ VisitHandler.java:221:INFO ] Found visitorId [10000] in cookie

2010-03-09 18:11:30,141 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0010s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-09 18:11:30,144 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-09 18:11:30,168 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0090s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-09 18:11:30,174 (http-0.0.0.0-8443-4) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.038s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-09 18:11:30,225 (http-0.0.0.0-8443-4) [ RequestHandler.java:716:INFO ] Rendering View [login], sessionId=DBA77007FAB03132F70108BBFEE78507.jvm1

2010-03-09 18:11:30,325 (http-0.0.0.0-8443-4) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-09 18:11:30,334 (http-0.0.0.0-8443-4) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-09 18:11:30,346 (http-0.0.0.0-8443-4) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-09 18:11:30,350 (http-0.0.0.0-8443-4) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]

2010-03-09 18:11:30,578 (http-0.0.0.0-8443-4) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [ServerHitBin]; curSeqId=11320, maxSeqId=11330, bankSize=10

2010-03-09 18:11:30,581 (http-0.0.0.0-8443-4) [ ControlServlet.java:312:INFO ] [[[Preferences] Request Done- total:0.494,since last([Preferences] Req...):0.494]]

2010-03-09 18:15:30,991 (default-invoker-Thread-29018) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-29018] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 18:15:31,023 (default-invoker-Thread-29018) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@21e41125[15220] -- Next runtime: Tue Mar 09 19:15:31 CET 2010

2010-03-09 18:15:31,111 (default-invoker-Thread-29018) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 18:15:31,123 (default-invoker-Thread-29018) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 18:15:31,123 (default-invoker-Thread-29018) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/fixedAssetPermissionCheck] finished in [90] milliseconds

2010-03-09 18:15:31,191 (default-invoker-Thread-29018) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [159] milliseconds

2010-03-09 19:11:39,689 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: DBA77007FAB03132F70108BBFEE78507.jvm1

2010-03-09 19:15:33,128 (default-invoker-Thread-30009) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30009] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 19:15:33,179 (default-invoker-Thread-30009) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@332a6bf0[15221] -- Next runtime: Tue Mar 09 20:15:33 CET 2010

2010-03-09 19:15:33,223 (default-invoker-Thread-30009) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 19:15:33,234 (default-invoker-Thread-30009) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 19:15:33,293 (default-invoker-Thread-30009) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-09 20:15:35,977 (default-invoker-Thread-30005) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30005] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 20:15:36,007 (default-invoker-Thread-30005) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@56568779[15222] -- Next runtime: Tue Mar 09 21:15:35 CET 2010

2010-03-09 20:15:36,053 (default-invoker-Thread-30005) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 20:15:36,064 (default-invoker-Thread-30005) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 20:15:36,123 (default-invoker-Thread-30005) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-09 21:15:38,075 (default-invoker-Thread-30006) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30006] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 21:15:38,096 (default-invoker-Thread-30006) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7c9d7b37[15223] -- Next runtime: Tue Mar 09 22:15:38 CET 2010

2010-03-09 21:15:38,140 (default-invoker-Thread-30006) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 21:15:38,151 (default-invoker-Thread-30006) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 21:15:38,211 (default-invoker-Thread-30006) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-09 22:15:40,923 (default-invoker-Thread-30005) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30005] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 22:15:40,950 (default-invoker-Thread-30005) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@dc3fbbc[15224] -- Next runtime: Tue Mar 09 23:15:40 CET 2010

2010-03-09 22:15:40,995 (default-invoker-Thread-30005) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 22:15:41,006 (default-invoker-Thread-30005) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 22:15:41,065 (default-invoker-Thread-30005) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-09 23:15:43,026 (default-invoker-Thread-30008) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30008] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-09 23:15:43,057 (default-invoker-Thread-30008) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@71ebe4[15225] -- Next runtime: Wed Mar 10 00:15:43 CET 2010

2010-03-09 23:15:43,103 (default-invoker-Thread-30008) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-09 23:15:43,114 (default-invoker-Thread-30008) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-09 23:15:43,174 (default-invoker-Thread-30008) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [109] milliseconds

2010-03-10 00:00:05,073 (default-invoker-Thread-30007) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30007] received job [Purge Old Jobs] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:00:05,074 (default-invoker-Thread-30009) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30009] received job [Re-Try Failed Auths NSF] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:00:05,077 (default-invoker-Thread-30006) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30006] received job [Create Also Bought Product Associations] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:00:05,078 (default-invoker-Thread-30008) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30008] received job [Extend expired Subscriptions] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:00:05,079 (default-invoker-Thread-30005) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30005] received job [Re-Try Failed Auths] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:00:05,128 (default-invoker-Thread-30007) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@707257d7[15202] -- Next runtime: Thu Mar 11 00:00:00 CET 2010

2010-03-10 00:00:05,129 (default-invoker-Thread-30009) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7eeab7d3[15201] -- Next runtime: Thu Mar 11 00:00:00 CET 2010

2010-03-10 00:00:05,128 (default-invoker-Thread-30006) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@62e51ded[15200] -- Next runtime: Thu Mar 11 00:00:00 CET 2010

2010-03-10 00:00:05,128 (default-invoker-Thread-30008) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@63990672[15199] -- Next runtime: Thu Mar 11 00:00:00 CET 2010

2010-03-10 00:00:05,128 (default-invoker-Thread-30005) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@300fe554[15198] -- Next runtime: Thu Mar 11 00:00:00 CET 2010

2010-03-10 00:00:05,151 (default-invoker-Thread-30007) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-10 00:00:05,175 (default-invoker-Thread-30009) [PaymentGatewayServices.java:2660:INFO ] Processing failed order re-auth(s)

2010-03-10 00:00:05,193 (default-invoker-Thread-30008) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30008] received job [Clear EntitySyncRemove Info] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:00:05,195 (default-invoker-Thread-30005) [PaymentGatewayServices.java:2611:INFO ] Processing failed order re-auth(s)

2010-03-10 00:00:05,204 (default-invoker-Thread-30008) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7b13a68b[15197] -- Next runtime: Thu Mar 11 00:00:00 CET 2010

2010-03-10 00:00:05,208 (default-invoker-Thread-30008) [ EntitySyncServices.java:600:INFO ] Running cleanSyncRemoveInfo

2010-03-10 00:00:05,251 (default-invoker-Thread-30008) [ EntitySyncServices.java:627:INFO ] In cleanSyncRemoveInfo removed [36] values with TX timestamp before [2010-03-09 23:36:05.213]

2010-03-10 00:00:05,274 (default-invoker-Thread-30009) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30009] received job [Purge Old Store Auto-Entered Promos] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:00:05,294 (default-invoker-Thread-30005) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30005] received job [BackOrder Notification] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:00:05,295 (default-invoker-Thread-30006) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30006] received job [Run Auto-Reorders] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:00:05,299 (default-invoker-Thread-30009) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@b7aaa76[15192] -- Next runtime: Thu Mar 11 00:00:00 CET 2010

2010-03-10 00:00:05,299 (default-invoker-Thread-30008) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30008] received job [Cancels all orders after date] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:00:05,314 (default-invoker-Thread-30006) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@195188c3[15194] -- Next runtime: Thu Mar 11 00:00:00 CET 2010

2010-03-10 00:00:05,317 (default-invoker-Thread-30008) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7cbe7a0e[15196] -- Next runtime: Thu Mar 11 00:00:00 CET 2010

2010-03-10 00:00:05,329 (default-invoker-Thread-30005) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6401d511[15193] -- Next runtime: Thu Mar 11 00:00:00 CET 2010

2010-03-10 00:00:05,330 (default-invoker-Thread-30009) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-30009] received job [Replacement Held Order Auto-Cancel] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:00:05,343 (default-invoker-Thread-30009) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4b749c7f[15195] -- Next runtime: Thu Mar 11 00:00:00 CET 2010

2010-03-10 00:00:05,424 (default-invoker-Thread-30005) [ InventoryServices.java:380:INFO ] OOS Inventory Items: 0

2010-03-10 00:00:05,425 (default-invoker-Thread-30005) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/checkInventoryAvailability] finished in [93] milliseconds

2010-03-10 00:00:05,442 (default-invoker-Thread-30006) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/runShoppingListAutoReorder] finished in [112] milliseconds

2010-03-10 00:00:05,442 (default-invoker-Thread-30009) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/autoCancelReplacementOrders] finished in [96] milliseconds

2010-03-10 00:00:05,454 (default-invoker-Thread-30008) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/cancelAllBackOrders] finished in [135] milliseconds

2010-03-10 00:00:05,554 (default-invoker-Thread-30007) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [EntitySyncRemove]; curSeqId=14550, maxSeqId=14560, bankSize=10

2010-03-10 00:00:05,665 (default-invoker-Thread-30007) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [EntitySyncRemove]; curSeqId=14560, maxSeqId=14570, bankSize=10

2010-03-10 00:00:05,776 (default-invoker-Thread-30007) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [EntitySyncRemove]; curSeqId=14570, maxSeqId=14580, bankSize=10

2010-03-10 00:00:05,880 (default-invoker-Thread-30007) [ TransactionUtil.java:406:WARN ] No transaction in place, so not suspending.

2010-03-10 00:00:05,894 (default-invoker-Thread-30007) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/purgeOldJobs] finished in [738] milliseconds

2010-03-10 00:15:45,478 (default-invoker-Thread-31161) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-31161] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 00:15:45,485 (default-invoker-Thread-31161) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@29446ca2[15226] -- Next runtime: Wed Mar 10 01:15:45 CET 2010

2010-03-10 00:15:45,523 (default-invoker-Thread-31161) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 00:15:45,528 (default-invoker-Thread-31161) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 00:15:45,590 (default-invoker-Thread-31161) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [103] milliseconds

2010-03-10 01:15:47,984 (default-invoker-Thread-31162) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-31162] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 01:15:48,016 (default-invoker-Thread-31162) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@24bb4654[15238] -- Next runtime: Wed Mar 10 02:15:47 CET 2010

2010-03-10 01:15:48,061 (default-invoker-Thread-31162) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 01:15:48,073 (default-invoker-Thread-31162) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 01:15:48,132 (default-invoker-Thread-31162) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-10 02:15:50,838 (default-invoker-Thread-31163) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-31163] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 02:15:50,869 (default-invoker-Thread-31163) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@40d92fe8[15239] -- Next runtime: Wed Mar 10 03:15:50 CET 2010

2010-03-10 02:15:50,915 (default-invoker-Thread-31163) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 02:15:50,925 (default-invoker-Thread-31163) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 02:15:50,985 (default-invoker-Thread-31163) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-10 03:15:52,979 (default-invoker-Thread-31162) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-31162] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 03:15:53,001 (default-invoker-Thread-31162) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@4eb608d5[15240] -- Next runtime: Wed Mar 10 04:15:52 CET 2010

2010-03-10 03:15:53,045 (default-invoker-Thread-31162) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 03:15:53,056 (default-invoker-Thread-31162) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 03:15:53,115 (default-invoker-Thread-31162) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-10 04:15:55,065 (default-invoker-Thread-31162) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-31162] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 04:15:55,084 (default-invoker-Thread-31162) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@45bbab64[15241] -- Next runtime: Wed Mar 10 05:15:55 CET 2010

2010-03-10 04:15:55,128 (default-invoker-Thread-31162) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 04:15:55,139 (default-invoker-Thread-31162) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 04:15:55,199 (default-invoker-Thread-31162) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-10 05:15:57,918 (default-invoker-Thread-32130) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-32130] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 05:15:57,943 (default-invoker-Thread-32130) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@32fc1bd9[15242] -- Next runtime: Wed Mar 10 06:15:57 CET 2010

2010-03-10 05:15:57,987 (default-invoker-Thread-32130) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 05:15:57,998 (default-invoker-Thread-32130) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 05:15:58,057 (default-invoker-Thread-32130) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-10 06:16:00,011 (default-invoker-Thread-32131) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-32131] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 06:16:00,040 (default-invoker-Thread-32131) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@2afd3666[15243] -- Next runtime: Wed Mar 10 07:16:00 CET 2010

2010-03-10 06:16:00,084 (default-invoker-Thread-32131) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 06:16:00,095 (default-invoker-Thread-32131) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 06:16:00,154 (default-invoker-Thread-32131) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-10 07:16:02,149 (default-invoker-Thread-32133) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-32133] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 07:16:02,170 (default-invoker-Thread-32133) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@6861e315[15244] -- Next runtime: Wed Mar 10 08:16:02 CET 2010

2010-03-10 07:16:02,215 (default-invoker-Thread-32133) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 07:16:02,225 (default-invoker-Thread-32133) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 07:16:02,286 (default-invoker-Thread-32133) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-10 08:16:05,003 (default-invoker-Thread-32134) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-32134] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 08:16:05,036 (default-invoker-Thread-32134) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@3defdefd[15245] -- Next runtime: Wed Mar 10 09:16:05 CET 2010

2010-03-10 08:16:05,081 (default-invoker-Thread-32134) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 08:16:05,092 (default-invoker-Thread-32134) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 08:16:05,151 (default-invoker-Thread-32134) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [107] milliseconds

2010-03-10 09:16:07,119 (default-invoker-Thread-32131) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-32131] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 09:16:07,149 (default-invoker-Thread-32131) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@295cb59[15246] -- Next runtime: Wed Mar 10 10:16:07 CET 2010

2010-03-10 09:16:07,194 (default-invoker-Thread-32131) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 09:16:07,206 (default-invoker-Thread-32131) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 09:16:07,266 (default-invoker-Thread-32131) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [109] milliseconds

2010-03-10 10:16:09,967 (default-invoker-Thread-33099) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-33099] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 10:16:09,991 (default-invoker-Thread-33099) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@17f1e7df[15247] -- Next runtime: Wed Mar 10 11:16:09 CET 2010

2010-03-10 10:16:10,038 (default-invoker-Thread-33099) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 10:16:10,048 (default-invoker-Thread-33099) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 10:16:10,108 (default-invoker-Thread-33099) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [108] milliseconds

2010-03-10 10:30:58,360 (http-0.0.0.0-8443-9) [ControlEventListener.java:63 :INFO ] Creating session: 5C1FCE237F00158197CF998493E7ED50.jvm1

2010-03-10 10:30:58,361 (http-0.0.0.0-8443-9) [ ControlServlet.java:134:INFO ] [[[Preferences] Request Begun, encoding=[UTF-8]- total:0.0,since last(Begin):0.0]]

2010-03-10 10:30:58,361 (http-0.0.0.0-8443-9) [ VisitHandler.java:221:INFO ] Found visitorId [10000] in cookie

2010-03-10 10:30:58,401 (http-0.0.0.0-8443-9) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 18 requests, 14 views in file:/var/www/sitios/ofbiz/framework/common/webcommon/WEB-INF/common-controller.xml

2010-03-10 10:30:58,405 (http-0.0.0.0-8443-9) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.0s, 4 requests, 2 views in file:/var/www/sitios/ofbiz/applications/commonext/webapp/WEB-INF/controller.xml

2010-03-10 10:30:58,452 (http-0.0.0.0-8443-9) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.032s, 376 requests, 162 views in file:/var/www/sitios/ofbiz/applications/content/webapp/content/WEB-INF/controller.xml

2010-03-10 10:30:58,458 (http-0.0.0.0-8443-9) [ ConfigXMLReader.java:118:INFO ] controller loaded: 0.062s, 620 requests, 254 views in jndi:/0.0.0.0/partymgr/WEB-INF/controller.xml

2010-03-10 10:30:58,459 (http-0.0.0.0-8443-9) [ RequestHandler.java:716:INFO ] Rendering View [login], sessionId=5C1FCE237F00158197CF998493E7ED50.jvm1

2010-03-10 10:30:58,513 (http-0.0.0.0-8443-9) [ ScreenFactory.java:129:INFO ] Got 22 screens in 0.01s from: file:/var/www/sitios/ofbiz/framework/common/widget/CommonScreens.xml

2010-03-10 10:30:58,522 (http-0.0.0.0-8443-9) [ ScreenFactory.java:129:INFO ] Got 6 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/party/widget/partymgr/CommonScreens.xml

2010-03-10 10:30:58,534 (http-0.0.0.0-8443-9) [ ScreenFactory.java:129:INFO ] Got 1 screens in 0.0080s from: file:/var/www/sitios/ofbiz/applications/commonext/widget/CommonScreens.xml

2010-03-10 10:30:58,538 (http-0.0.0.0-8443-9) [ PrimaryKeyFinder.java:142:INFO ] Returning null because found incomplete primary key in find: [GenericEntity:PartyNameView][partyId,null()]

2010-03-10 10:30:58,735 (http-0.0.0.0-8443-9) [ ControlServlet.java:312:INFO ] [[[Preferences] Request Done- total:0.374,since last([Preferences] Req...):0.374]]

2010-03-10 11:16:12,134 (default-invoker-Thread-33102) [ JobInvoker.java:232:INFO ] Invoker [default-invoker-Thread-33102] received job [Auto-create Fixed Asset Maintenances] from poller [org.ofbiz.service.job.JobPoller@1d722268]

2010-03-10 11:16:12,168 (default-invoker-Thread-33102) [PersistedServiceJob.java:178:INFO ] org.ofbiz.service.job.PersistedServiceJob@7adb22e3[15248] -- Next runtime: Wed Mar 10 12:16:12 CET 2010

2010-03-10 11:16:12,214 (default-invoker-Thread-33102) [ Log.java:111:INFO ] [CommonPermissionServices.xml#genericBasePermissionCheck] Checking for primary permission ACCOUNTING_CREATE

2010-03-10 11:16:12,227 (default-invoker-Thread-33102) [ ServiceEcaRule.java:134:INFO ] For Service ECA [fixedAssetPermissionCheck] on [return] got false for condition: [hasPermission][equals][false][true][Boolean]

2010-03-10 11:16:12,291 (default-invoker-Thread-33102) [ ServiceDispatcher.java:586:INFO ] Sync service [JobDispatcher/createMaintsFromTimeInterval] finished in [115] milliseconds

2010-03-10 11:31:49,475 (ContainerBackgroundProcessor[StandardEngine[default-server]]) [ControlEventListener.java:101:INFO ] Destroying session: 5C1FCE237F00158197CF998493E7ED50.jvm1