INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,890 (http-0.0.0.0-8080-3) [ ControlServlet.java:93 :INFO ] The character encoding of the request is: [null]. The character encoding we will use for the request and response is: [UTF-8] INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,890 (http-0.0.0.0-8080-3) [ ControlServlet.java:131:INFO ] [[[order.pdf] Servlet Starting, doing setup- total:0.0,since last(Begin):0.0]] INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,890 (http-0.0.0.0-8080-3) [ ControlServlet.java:190:INFO ] [[[order.pdf] Setup done, doing Event(s) and View(s)- total:0.0,since last([order.pdf] Servl...):0.0]] INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,906 (http-0.0.0.0-8080-3) [ UtilXml.java:241:INFO ] XML Read 0.016s: jndi:/0.0.0.0/pmacanada/WEB-INF/controller.xml INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,906 (http-0.0.0.0-8080-3) [ ConfigXMLReader.java:653:INFO ] ConfigMap Created: (5) records in 0.0s INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,906 (http-0.0.0.0-8080-3) [ ConfigXMLReader.java:811:INFO ] HandlerMap Created: (4) view handlers and (7) request/event handlers in 0.0s INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,921 (http-0.0.0.0-8080-3) [ ConfigXMLReader.java:386:INFO ] RequestMap Created: (245) records in 0.015s INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,921 (http-0.0.0.0-8080-3) [ ConfigXMLReader.java:480:INFO ] ViewMap Created: (89) records in 0.0s INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,921 (http-0.0.0.0-8080-3) [ RequestManager.java:122:INFO ] [RequestManager.getRequestAttribute] Value for attribute "track-visit" of uri "order.pdf" not found INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,921 (http-0.0.0.0-8080-3) [ RequestHandler.java:243:INFO ] [Processing Request]: cms sessionId=66C0767C846EC5CD0469307D007FF74E.jvm1 INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,921 (http-0.0.0.0-8080-3) [ CmsEvents.java:125:INFO ] Path INFO for Alias: order.pdf INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,921 (http-0.0.0.0-8080-3) [ CmsEvents.java:162:INFO ] Current PathInfo: order.pdf INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,921 (http-0.0.0.0-8080-3) [ CmsEvents.java:227:INFO ] No website [pmacanada] publish point found for contentId: order.pdf INFO | jvm 3 | 2008/06/13 14:31:25 | 2008-06-13 14:31:25,921 (http-0.0.0.0-8080-3) [ RequestManager.java:122:INFO ] [RequestManager.getRequestAttribute] Value for attribute "track-serverhit" of uri "order.pdf" not found INFO | jvm 3 | 2008/06/13 14:31:26 | 2008-06-13 14:31:25,984 (http-0.0.0.0-8080-3) [ SequenceUtil.java:341:INFO ] Got bank of sequenced IDs for [ServerHitBin]; curSeqId=24840, maxSeqId=24850, bankSize=10 INFO | jvm 3 | 2008/06/13 14:31:26 | 2008-06-13 14:31:26,000 (http-0.0.0.0-8080-3) [ RequestHandler.java:438:INFO ] [RequestHandler.doRequest]: Response is handled by the event. sessionId=66C0767C846EC5CD0469307D007FF74E.jvm1 INFO | jvm 3 | 2008/06/13 14:31:26 | 2008-06-13 14:31:26,000 (http-0.0.0.0-8080-3) [ RequestManager.java:122:INFO ] [RequestManager.getRequestAttribute] Value for attribute "track-serverhit" of uri "order.pdf" not found INFO | jvm 3 | 2008/06/13 14:31:26 | 2008-06-13 14:31:26,093 (http-0.0.0.0-8080-3) [ ControlServlet.java:299:INFO ] [[[order.pdf] Done rendering page, Servlet Finished- total:0.203,since last([order.pdf] Setup...):0.203]] INFO | jvm 3 | 2008/06/13 14:31:30 | 2008-06-13 14:31:30,406 (default-invoker-Thread-35386) [ JobInvoker.java:230:INFO ] Invoker [default-invoker-Thread-35386] received job [1193830999234] from poller [org.ofbiz.service.job.JobPoller@21e554] INFO | jvm 3 | 2008/06/13 14:31:30 | 2008-06-13 14:31:30,406 (default-invoker-Thread-35386) [PersistedServiceJob.java:140:INFO ] org.ofbiz.service.job.PersistedServiceJob@113cd2e[547727] -- Next runtime: -1 INFO | jvm 3 | 2008/06/13 14:31:30 | 2008-06-13 14:31:30,406 (default-invoker-Thread-35386) [ UtilXml.java:241:INFO ] XML Read 0.0s: Internal Content INFO | jvm 3 | 2008/06/13 14:31:30 | 2008-06-13 14:31:30,406 (default-invoker-Thread-35386) [NotificationServices.java:204:ERROR] Problem getting the template URL: component://securityext/widget/EmailSecurityScreens.xml#PasswordEmail not found INFO | jvm 3 | 2008/06/13 14:31:30 | 2008-06-13 14:31:30,406 (default-invoker-Thread-35386) [NotificationServices.java:137:ERROR] prepareNotification failed: Problem finding template; see logs INFO | jvm 3 | 2008/06/13 14:31:30 | 2008-06-13 14:31:30,406 (default-invoker-Thread-35386) [NotificationServices.java:159:ERROR] Invalid email body; null is not allowed INFO | jvm 3 | 2008/06/13 14:31:30 | 2008-06-13 14:31:30,406 (default-invoker-Thread-35386) [ ServiceDispatcher.java:522:ERROR] Error in Service [sendGenericNotificationEmail]: Invalid email body; null is not allowed INFO | jvm 3 | 2008/06/13 14:31:30 | 2008-06-13 14:31:30,406 (default-invoker-Thread-35386) [ TransactionUtil.java:275:ERROR] INFO | jvm 3 | 2008/06/13 14:31:30 | ---- exception report ---------------------------------------------------------- INFO | jvm 3 | 2008/06/13 14:31:30 | [TransactionUtil.rollback] INFO | jvm 3 | 2008/06/13 14:31:30 | Exception: java.lang.Exception INFO | jvm 3 | 2008/06/13 14:31:30 | Message: Stack Trace INFO | jvm 3 | 2008/06/13 14:31:30 | ---- stack trace --------------------------------------------------------------- INFO | jvm 3 | 2008/06/13 14:31:30 | java.lang.Exception: Stack Trace INFO | jvm 3 | 2008/06/13 14:31:30 | org.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:274) INFO | jvm 3 | 2008/06/13 14:31:30 | org.ofbiz.entity.transaction.TransactionUtil.rollback(TransactionUtil.java:256) INFO | jvm 3 | 2008/06/13 14:31:30 | org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:526) INFO | jvm 3 | 2008/06/13 14:31:30 | org.ofbiz.service.ServiceDispatcher.runSync(ServiceDispatcher.java:213) INFO | jvm 3 | 2008/06/13 14:31:30 | org.ofbiz.service.GenericDispatcher.runSync(GenericDispatcher.java:149) INFO | jvm 3 | 2008/06/13 14:31:30 | org.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:69) INFO | jvm 3 | 2008/06/13 14:31:30 | org.ofbiz.service.job.JobInvoker.run(JobInvoker.java:240) INFO | jvm 3 | 2008/06/13 14:31:30 | java.lang.Thread.run(Unknown Source) INFO | jvm 3 | 2008/06/13 14:31:30 | -------------------------------------------------------------------------------- INFO | jvm 3 | 2008/06/13 14:31:30 | INFO | jvm 3 | 2008/06/13 14:31:30 | 2008-06-13 14:31:30,406 (default-invoker-Thread-35386) [ TransactionUtil.java:285:INFO ] [TransactionUtil.rollback] transaction rolled back INFO | jvm 3 | 2008/06/13 14:31:30 | 2008-06-13 14:31:30,421 (default-invoker-Thread-35386) [ GenericServiceJob.java:116:ERROR] INFO | jvm 3 | 2008/06/13 14:31:30 | ---- exception report ---------------------------------------------------------- INFO | jvm 3 | 2008/06/13 14:31:30 | Async-Service failed. INFO | jvm 3 | 2008/06/13 14:31:30 | Exception: java.lang.Exception INFO | jvm 3 | 2008/06/13 14:31:30 | Message: Invalid email body; null is not allowed INFO | jvm 3 | 2008/06/13 14:31:30 | ---- stack trace --------------------------------------------------------------- INFO | jvm 3 | 2008/06/13 14:31:30 | java.lang.Exception: Invalid email body; null is not allowed INFO | jvm 3 | 2008/06/13 14:31:30 | org.ofbiz.service.job.GenericServiceJob.exec(GenericServiceJob.java:75) INFO | jvm 3 | 2008/06/13 14:31:30 | org.ofbiz.service.job.JobInvoker.run(JobInvoker.java:240) INFO | jvm 3 | 2008/06/13 14:31:30 | java.lang.Thread.run(Unknown Source) INFO | jvm 3 | 2008/06/13 14:31:30 | -------------------------------------------------------------------------------- INFO | jvm 3 | 2008/06/13 14:31:30 | INFO | jvm 3 | 2008/06/13 14:31:30 | 2008-06-13 14:31:30,437 (default-invoker-Thread-35386) [PersistedServiceJob.java:205:INFO ] Persisted Job [547727] Failed Re-Scheduling : 1213347870421