1 2 Previous Next 29 Replies Latest reply on Jun 16, 2009 11:49 AM by pramod_bs

    Seam/Richfaces home page loading slow

    pramod_bs

      Gurus
      I have a seam/richfaces application. It is taking too much time to load the home page. From the access log (copied below) I can see some delay in the .js file loading (rich faces files). Any help will be much appreciated. I have to go to PRODUCTION soon and I am sure users are going to complain about this.

      8.15.129.134 - - [16/Mar/2009:09:17:38 -0500] "GET /autoauctions/home.seam HTTP/1.1" 200 100591
      8.15.129.134 - - [16/Mar/2009:09:17:41 -0500] "GET /autoauctions/a4j/g/3_3_0.GA/org/ajax4jsf/framework.pack.js HTTP/1.1" 200 303479
      8.15.129.134 - - [16/Mar/2009:09:17:49 -0500] "GET /autoauctions/a4j/g/3_3_0.GA/org/richfaces/ui.pack.js HTTP/1.1" 200 620864
      8.15.129.134 - - [16/Mar/2009:09:17:51 -0500] "GET /autoauctions/a4j/s/3_3_0.GA/org/richfaces/skin.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__ HTTP/1.1" 200 80861

        • 1. Re: Seam/Richfaces home page loading slow

          Take a look what third party compression filter you have declared in your web.xml.

          • 2. Re: Seam/Richfaces home page loading slow
            pramod_bs

            THis is what I have in web.xml.


            <?xml version="1.0" ?>
            <web-app xmlns="http://java.sun.com/xml/ns/javaee"
            xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
            xsi:schemaLocation="http://java.sun.com/xml/ns/javaee http://java.sun.com/xml/ns/javaee/web-app_2_5.xsd"
            version="2.5">

            <!-- RichFaces -->

            <context-param>
            <param-name>org.richfaces.SKIN</param-name>
            <param-value>blueSky</param-value>
            </context-param>

            <!-- Suppress spurious stylesheets -->

            <context-param>
            <param-name>org.richfaces.CONTROL_SKINNING</param-name>
            <param-value>disable</param-value>
            </context-param>

            <context-param>
            <param-name>org.richfaces.CONTROL_SKINNING_CLASSES</param-name>
            <param-value>disable</param-value>
            </context-param>

            <!-- Change load strategy to DEFAULT to disable sending scripts/styles as packs -->

            <context-param>
            <param-name>org.richfaces.LoadStyleStrategy</param-name>
            <param-value>ALL</param-value>
            </context-param>

            <context-param>
            <param-name>org.richfaces.LoadScriptStrategy</param-name>
            <param-value>ALL</param-value>
            </context-param>

            <!-- Seam -->


            <listener-class>org.jboss.seam.servlet.SeamListener</listener-class>



            <filter-name>Seam Filter</filter-name>
            <filter-class>org.jboss.seam.servlet.SeamFilter</filter-class>


            <filter-mapping>
            <filter-name>Seam Filter</filter-name>
            <url-pattern>/*</url-pattern>
            </filter-mapping>


            <servlet-name>Seam Resource Servlet</servlet-name>
            <servlet-class>org.jboss.seam.servlet.SeamResourceServlet</servlet-class>


            <servlet-mapping>
            <servlet-name>Seam Resource Servlet</servlet-name>
            <url-pattern>/seam/resource/*</url-pattern>
            </servlet-mapping>

            <!-- Facelets development mode (disable in production) -->

            <context-param>
            <param-name>facelets.DEVELOPMENT</param-name>
            <param-value>true</param-value>
            </context-param>

            <!-- JSF -->

            <context-param>
            <param-name>javax.faces.DEFAULT_SUFFIX</param-name>
            <param-value>.xhtml</param-value>
            </context-param>


            <servlet-name>Faces Servlet</servlet-name>
            <servlet-class>javax.faces.webapp.FacesServlet</servlet-class>
            <load-on-startup>1</load-on-startup>


            <servlet-mapping>
            <servlet-name>Faces Servlet</servlet-name>
            <url-pattern>*.seam</url-pattern>
            </servlet-mapping>

            <security-constraint>
            <display-name>Restrict raw XHTML Documents</display-name>
            <web-resource-collection>
            <web-resource-name>XHTML</web-resource-name>
            <url-pattern>*.xhtml</url-pattern>
            </web-resource-collection>
            <auth-constraint/>
            </security-constraint>



            </web-app>

            • 3. Re: Seam/Richfaces home page loading slow
              alexsmirnov

              Please, describe a more detail configuration of your environment. The lo looks like a Apache Httpd log - do you use it as front-end to a Java server ?
              If yes, what kind of connector do you use ? For my expirience, the mod_jk could provide a some delays. That module is deprecated in favour of mod_proxy & mod_proxy_ajp combination.
              For a production environment, take a look for http://www.jboss.org/community/docs/DOC-13329 . That tool helps to create application-specific assembly for JavaScript and CSS files, which could be significantly smaller then default all-in-one script is.

              • 4. Re: Seam/Richfaces home page loading slow
                pramod_bs

                The log is actually the access log from jboss/tomcat. We are not using apache. We just use JBoss 4.2.1 , Seam 2.1 and RIchfaces 3.3.0. Any help will be very much appreciated. Is there any other log settings I need to do for more detailed logging.

                • 5. Re: Seam/Richfaces home page loading slow
                  nbelaevski

                  Hello,

                  You can switch on logging from RF BaseFilter that serves resources. Here is my log4j.xml:

                  <?xml version="1.0" encoding="UTF-8"?>
                  <!DOCTYPE log4j:configuration SYSTEM "log4j.dtd">
                  
                  <log4j:configuration xmlns:log4j="http://jakarta.apache.org/log4j/"
                   debug="false">
                  
                   <!-- ============================== -->
                   <!-- Append messages to the console -->
                   <!-- ============================== -->
                  
                   <appender name="CONSOLE" class="org.apache.log4j.ConsoleAppender">
                   <param name="Target" value="System.out" />
                   <param name="Threshold" value="INFO" />
                  
                   <layout class="org.apache.log4j.PatternLayout">
                   <!-- The default pattern: Date Priority [Category] Message\n -->
                   <param name="ConversionPattern" value="%d{ABSOLUTE} %-5p [%c{1}] %m%n" />
                   </layout>
                  
                   </appender>
                   <appender name="CONSOLE_DEBUG" class="org.apache.log4j.ConsoleAppender">
                   <param name="Target" value="System.out" />
                   <param name="Threshold" value="DEBUG" />
                  
                   <layout class="org.apache.log4j.PatternLayout">
                   <!-- The default pattern: Date Priority [Category] Message\n -->
                   <param name="ConversionPattern" value="%d{ABSOLUTE} %-5p [%c{1}] %m%n" />
                   </layout>
                  
                   </appender>
                  
                   <logger name="org.ajax4jsf.webapp">
                   <level value="debug" />
                   <appender-ref ref="CONSOLE_DEBUG" />
                   </logger>
                   <root>
                   <appender-ref ref="CONSOLE" />
                   </root>
                  
                  </log4j:configuration>


                  • 6. Re: Seam/Richfaces home page loading slow
                    pramod_bs

                    It sesms like the TidyParser was taking too much time to parse. When I added the foll in web.xml it speeds up the loading.

                    <context-param>
                    <param-name>org.ajax4jsf.xmlparser.ORDER</param-name>
                    <param-value>NONE</param-value>
                    </context-param>

                    Hopefully this will not cause any other issues.

                    • 7. Re: Seam/Richfaces home page loading slow
                      nbelaevski

                      Hello,

                      NONE parser does very limited processing, so some things won't work (search JIRA for more). I'd recommend to check if NEKO parser performance satisfies you if you encounter some problems.

                      • 8. Re: Seam/Richfaces home page loading slow
                        pramod_bs

                        I am still sticking with the NONE parser. Here is the log and I am still not happy with the performance. From the log below please see the time it takes to load the js files. Is there any other way of optimizing this. Please help.


                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,303 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,303 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,303 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,319 INFO [Contexts] starting up: org.jboss.seam.web.session
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,319 INFO [Contexts] starting up: org.jboss.seam.security.identity
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,319 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,319 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: text/html
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,319 DEBUG [BaseXMLFilter] Parsing html total time 0ms
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,319 DEBUG [BaseFilter] Finished request processing total time 16ms for uri: /autoauctions/
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,522 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/home.seam
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,522 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,522 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,553 DEBUG [FilterServletResponseWrapper] Create StringWriter for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,600 INFO [STDOUT] Hibernate:
                        INFO | jvm 1 | 2009/05/04 15:33:10 | select
                        INFO | jvm 1 | 2009/05/04 15:33:10 | distinct states0_.state as col_0_0_
                        INFO | jvm 1 | 2009/05/04 15:33:10 | from
                        INFO | jvm 1 | 2009/05/04 15:33:10 | remarketmysql.states states0_
                        INFO | jvm 1 | 2009/05/04 15:33:10 | where
                        INFO | jvm 1 | 2009/05/04 15:33:10 | (
                        INFO | jvm 1 | 2009/05/04 15:33:10 | states0_.state is not null
                        INFO | jvm 1 | 2009/05/04 15:33:10 | )
                        INFO | jvm 1 | 2009/05/04 15:33:10 | and states0_.sID<53
                        INFO | jvm 1 | 2009/05/04 15:33:10 | order by
                        INFO | jvm 1 | 2009/05/04 15:33:10 | states0_.state
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,600 INFO [STDOUT] Hibernate:
                        INFO | jvm 1 | 2009/05/04 15:33:10 | select
                        INFO | jvm 1 | 2009/05/04 15:33:10 | distinct auctionhou0_.AuctionHouseName as col_0_0_
                        INFO | jvm 1 | 2009/05/04 15:33:10 | from
                        INFO | jvm 1 | 2009/05/04 15:33:10 | remarketmysql.auctionhouse auctionhou0_
                        INFO | jvm 1 | 2009/05/04 15:33:10 | where
                        INFO | jvm 1 | 2009/05/04 15:33:10 | (
                        INFO | jvm 1 | 2009/05/04 15:33:10 | auctionhou0_.AuctionHouseName is not null
                        INFO | jvm 1 | 2009/05/04 15:33:10 | )
                        INFO | jvm 1 | 2009/05/04 15:33:10 | and auctionhou0_.activeFlag='Y'
                        INFO | jvm 1 | 2009/05/04 15:33:10 | order by
                        INFO | jvm 1 | 2009/05/04 15:33:10 | auctionhou0_.AuctionHouseName
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,647 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: text/html; charset=UTF-8
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,663 DEBUG [BaseXMLFilter] Parsing html total time 16ms
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,663 DEBUG [BaseFilter] Finished request processing total time 141ms for uri: /autoauctions/home.seam
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,819 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/s/3_3_0.GAcss/panel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,819 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/s/3_3_0.GAcss/panel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,913 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/s/3_3_0.GAcss/toolBar.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:10 | 15:33:10,928 DEBUG [BaseFilter] Finished request processing total time 15ms for uri: /autoauctions/a4j/s/3_3_0.GAcss/toolBar.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:11 | 15:33:11,022 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.PrototypeScript
                        INFO | jvm 1 | 2009/05/04 15:33:11 | 15:33:11,897 DEBUG [BaseFilter] Finished request processing total time 875ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.PrototypeScript
                        INFO | jvm 1 | 2009/05/04 15:33:12 | 15:33:12,319 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.AjaxScript
                        INFO | jvm 1 | 2009/05/04 15:33:12 | 15:33:12,319 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.AjaxScript
                        INFO | jvm 1 | 2009/05/04 15:33:13 | 15:33:13,366 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/available.js
                        INFO | jvm 1 | 2009/05/04 15:33:13 | 15:33:13,366 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/available.js
                        INFO | jvm 1 | 2009/05/04 15:33:13 | 15:33:13,506 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/jquery/jquery.js
                        INFO | jvm 1 | 2009/05/04 15:33:14 | 15:33:14,038 DEBUG [BaseFilter] Finished request processing total time 532ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/jquery/jquery.js
                        INFO | jvm 1 | 2009/05/04 15:33:14 | 15:33:14,303 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/script/controlUtils.js
                        INFO | jvm 1 | 2009/05/04 15:33:14 | 15:33:14,303 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/script/controlUtils.js
                        INFO | jvm 1 | 2009/05/04 15:33:14 | 15:33:14,413 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/utils.js
                        INFO | jvm 1 | 2009/05/04 15:33:14 | 15:33:14,413 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/utils.js
                        INFO | jvm 1 | 2009/05/04 15:33:14 | 15:33:14,600 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/browser_info.js
                        INFO | jvm 1 | 2009/05/04 15:33:14 | 15:33:14,600 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/browser_info.js
                        INFO | jvm 1 | 2009/05/04 15:33:14 | 15:33:14,710 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/modalPanel.js
                        INFO | jvm 1 | 2009/05/04 15:33:14 | 15:33:14,710 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/modalPanel.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:14,991 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/modalPanelBorders.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:14,991 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/modalPanelBorders.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,178 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/s/3_3_0.GAorg/richfaces/renderkit/html/css/modalPanel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,178 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/s/3_3_0.GAorg/richfaces/renderkit/html/css/modalPanel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,272 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.ImageCacheScript
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,272 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.ImageCacheScript
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,366 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/ajax4jsf/javascript/scripts/form.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,366 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/ajax4jsf/javascript/scripts/form.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,475 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAscripts/simpleTogglePanel.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,475 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAscripts/simpleTogglePanel.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,585 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/s/3_3_0.GAcss/simpleTogglePanel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,585 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/s/3_3_0.GAcss/simpleTogglePanel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,678 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAscripts/comboboxUtils.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,678 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAscripts/comboboxUtils.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,788 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAscripts/combolist.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,788 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAscripts/combolist.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,991 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAscripts/combobox.js
                        INFO | jvm 1 | 2009/05/04 15:33:15 | 15:33:15,991 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAscripts/combobox.js
                        INFO | jvm 1 | 2009/05/04 15:33:16 | 15:33:16,194 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAscripts/comboboxstyles.js
                        INFO | jvm 1 | 2009/05/04 15:33:16 | 15:33:16,194 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAscripts/comboboxstyles.js
                        INFO | jvm 1 | 2009/05/04 15:33:16 | 15:33:16,303 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/s/3_3_0.GAcss/combobox.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:16 | 15:33:16,303 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/s/3_3_0.GAcss/combobox.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:16 | 15:33:16,428 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/events.js
                        INFO | jvm 1 | 2009/05/04 15:33:16 | 15:33:16,428 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/events.js
                        INFO | jvm 1 | 2009/05/04 15:33:16 | 15:33:16,538 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/json/json-dom.js
                        INFO | jvm 1 | 2009/05/04 15:33:16 | 15:33:16,538 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/json/json-dom.js
                        INFO | jvm 1 | 2009/05/04 15:33:16 | 15:33:16,647 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/scriptaculous/effects.js
                        INFO | jvm 1 | 2009/05/04 15:33:16 | 15:33:16,647 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/scriptaculous/effects.js
                        INFO | jvm 1 | 2009/05/04 15:33:17 | 15:33:17,069 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/JQuerySpinBtn.js
                        INFO | jvm 1 | 2009/05/04 15:33:17 | 15:33:17,069 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/JQuerySpinBtn.js
                        INFO | jvm 1 | 2009/05/04 15:33:17 | 15:33:17,194 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/calendar.js
                        INFO | jvm 1 | 2009/05/04 15:33:17 | 15:33:17,194 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/calendar.js
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,038 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/s/3_3_0.GAorg/richfaces/renderkit/html/css/calendar.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,053 DEBUG [BaseFilter] Finished request processing total time 15ms for uri: /autoauctions/a4j/s/3_3_0.GAorg/richfaces/renderkit/html/css/calendar.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,163 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/css/msg.css
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,163 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/css/msg.css
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,256 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/css/msgs.css
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,256 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/css/msgs.css
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,350 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/stylesheet/theme.css
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,350 DEBUG [BaseFilter] Filter request output to XML

                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,350 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,350 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,350 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: text/css
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,350 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,350 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/stylesheet/theme.css
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,460 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAimages/spacer.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,460 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/gsalogo.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,460 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,460 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,460 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,460 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAimages/spacer.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,460 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,460 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,460 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/gsalogo.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,538 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/usaflag1.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,538 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,538 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,538 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,538 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,538 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,538 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/usaflag1.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,553 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/usaflag2.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,553 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,553 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,553 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,553 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,553 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,553 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/usaflag2.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,616 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/Home.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,616 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,616 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,616 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,616 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,616 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,616 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/Home.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,647 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/login2.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,647 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,647 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,647 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,647 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,647 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,647 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/login2.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,694 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/Calendar.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,694 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,694 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,694 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,694 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,694 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,694 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/Calendar.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,710 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/FindVehicle.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,725 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,725 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,725 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,725 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,725 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,725 DEBUG [BaseFilter] Finished request processing total time 15ms for uri: /autoauctions/img/FindVehicle.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,772 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/Search.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,772 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,772 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,772 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,772 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,772 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,772 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/Search.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,788 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/FAQ.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,788 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,788 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,803 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,803 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,803 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,803 DEBUG [BaseFilter] Finished request processing total time 15ms for uri: /autoauctions/img/FAQ.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,850 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/login.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,850 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,850 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,850 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,850 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,850 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,850 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/login.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,866 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/tssearch.gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,866 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,866 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,866 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,866 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,866 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:18 | 15:33:18,866 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/tssearch.gif
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:18,928 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/img/close.png
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:18,928 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:18,928 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:18,928 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:18,928 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/png
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:18,928 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:18,928 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/close.png
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:18,944 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/images/spacer.gif
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:18,944 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/images/spacer.gif
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,006 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.GradientA/DATB/eAH7!!3Tj2v7mAAZZAV3
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,006 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.GradientA/DATB/eAH7!!3Tj2v7mAAZZAV3
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,022 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/2005Cavalier.jpg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,022 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,022 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,022 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: null
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,022 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/2005Cavalier.jpg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,069 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/2004Impala.jpg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,069 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,069 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,069 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,069 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/jpeg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,069 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,069 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/2004Impala.jpg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,100 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/2005TrailBlazer.jpg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,100 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,100 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,100 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,100 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/jpeg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,100 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,100 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/2005TrailBlazer.jpg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,303 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/2006ImpalaLTZ.jpg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,319 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,319 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,319 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,319 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/jpeg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,319 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,319 DEBUG [BaseFilter] Finished request processing total time 16ms for uri: /autoauctions/2006ImpalaLTZ.jpg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,335 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/images/bg_shadow.png
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,335 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/images/bg_shadow.png
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,397 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.iconimages.CalendarIcon/DATB/eAH7cW0fw6znAA8XBA4_
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,413 DEBUG [BaseFilter] Finished request processing total time 16ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.iconimages.CalendarIcon/DATB/eAH7cW0fw6znAA8XBA4_
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,475 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.iconimages.CalendarSeparator/DATB/eAFjYGAAAAADAAE_
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,475 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.iconimages.CalendarSeparator/DATB/eAFjYGAAAAADAAE_
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,694 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.images.SpinnerButtonGradient/DATB/eAH7!!3Tj2v7mAAZZAV3
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,694 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.images.ComboBoxArrowImage/DATB/eAFjYGD4f-!Y!!!!ARNrBaE_
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,694 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.images.SpinnerButtonGradient/DATB/eAH7!!3Tj2v7mAAZZAV3
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,694 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.images.ComboBoxArrowImage/DATB/eAFjYGD4f-!Y!!!!ARNrBaE_
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,772 DEBUG [BaseFilter] Filter start request processing at 5/4/09 3:33 PM for uri: /autoauctions/2005Cavalier.jpg
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,772 DEBUG [BaseFilter] Filter request output to XML
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,772 DEBUG [BaseXMLFilter] XML filter service start processing request
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,772 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: null
                        INFO | jvm 1 | 2009/05/04 15:33:19 | 15:33:19,772 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/2005Cavalier.jpg



                          • 9. Re: Seam/Richfaces home page loading slow
                            nbelaevski

                            Can you please check how fast static resources of the same size are handled (e.g. save jQuery.js, put it into webapp and check)?

                            • 10. Re: Seam/Richfaces home page loading slow
                              pramod_bs

                              nickbelaevski
                              I didn't understand what you mean. I'm sorry. Can you please clarify. Do you mean I have to copy jsquery.js into webapp and load the application again. Just curious to know how it helps.

                              • 11. Re: Seam/Richfaces home page loading slow
                                pramod_bs

                                I added a datatable with jquery in the homepage. Here is the log.

                                I was wondering what is the best way to optimize this js loading. I tried all sorts of thing to make my homepage load fast but with not much results. After the home page is loaded when this page is revsited it flies. Please help. I have a very good application developed using Seam/Richfaces and I am threatened that this application will be thrown out if the performance is not improved. Lot of things are at stake.




                                INFO | jvm 1 | 2009/05/04 22:30:39 | 22:30:39,303 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/
                                INFO | jvm 1 | 2009/05/04 22:30:39 | 22:30:39,303 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:30:39 | 22:30:39,303 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:30:39 | 22:30:39,303 INFO [Contexts] starting up: org.jboss.seam.web.session
                                INFO | jvm 1 | 2009/05/04 22:30:39 | 22:30:39,303 INFO [Contexts] starting up: org.jboss.seam.security.identity
                                INFO | jvm 1 | 2009/05/04 22:30:39 | 22:30:39,303 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:30:39 | 22:30:39,303 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: text/html
                                INFO | jvm 1 | 2009/05/04 22:30:39 | 22:30:39,303 DEBUG [BaseXMLFilter] Parsing html total time 0ms
                                INFO | jvm 1 | 2009/05/04 22:30:39 | 22:30:39,303 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/
                                INFO | jvm 1 | 2009/05/04 22:30:40 | 22:30:39,991 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/home.seam
                                INFO | jvm 1 | 2009/05/04 22:30:40 | 22:30:39,991 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:30:40 | 22:30:39,991 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:30:40 | 22:30:40,085 DEBUG [FilterServletResponseWrapper] Create StringWriter for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:30:40 | 22:30:40,116 INFO [STDOUT] Hibernate:
                                INFO | jvm 1 | 2009/05/04 22:30:40 | select
                                INFO | jvm 1 | 2009/05/04 22:30:40 | distinct states0_.state as col_0_0_
                                INFO | jvm 1 | 2009/05/04 22:30:40 | from
                                INFO | jvm 1 | 2009/05/04 22:30:40 | remarketmysql.states states0_
                                INFO | jvm 1 | 2009/05/04 22:30:40 | where
                                INFO | jvm 1 | 2009/05/04 22:30:40 | (
                                INFO | jvm 1 | 2009/05/04 22:30:40 | states0_.state is not null
                                INFO | jvm 1 | 2009/05/04 22:30:40 | )
                                INFO | jvm 1 | 2009/05/04 22:30:40 | and states0_.sID<53
                                INFO | jvm 1 | 2009/05/04 22:30:40 | order by
                                INFO | jvm 1 | 2009/05/04 22:30:40 | states0_.state
                                INFO | jvm 1 | 2009/05/04 22:30:40 | 22:30:40,116 INFO [STDOUT] Hibernate:
                                INFO | jvm 1 | 2009/05/04 22:30:40 | select
                                INFO | jvm 1 | 2009/05/04 22:30:40 | distinct auctionhou0_.AuctionHouseName as col_0_0_
                                INFO | jvm 1 | 2009/05/04 22:30:40 | from
                                INFO | jvm 1 | 2009/05/04 22:30:40 | remarketmysql.auctionhouse auctionhou0_
                                INFO | jvm 1 | 2009/05/04 22:30:40 | where
                                INFO | jvm 1 | 2009/05/04 22:30:40 | (
                                INFO | jvm 1 | 2009/05/04 22:30:40 | auctionhou0_.AuctionHouseName is not null
                                INFO | jvm 1 | 2009/05/04 22:30:40 | )
                                INFO | jvm 1 | 2009/05/04 22:30:40 | and auctionhou0_.activeFlag='Y'
                                INFO | jvm 1 | 2009/05/04 22:30:40 | order by
                                INFO | jvm 1 | 2009/05/04 22:30:40 | auctionhou0_.AuctionHouseName
                                INFO | jvm 1 | 2009/05/04 22:30:40 | 22:30:40,147 INFO [STDOUT] Hibernate:
                                INFO | jvm 1 | 2009/05/04 22:30:40 | select
                                INFO | jvm 1 | 2009/05/04 22:30:40 | distinct states0_.state as col_0_0_
                                INFO | jvm 1 | 2009/05/04 22:30:40 | from
                                INFO | jvm 1 | 2009/05/04 22:30:40 | remarketmysql.states states0_
                                INFO | jvm 1 | 2009/05/04 22:30:40 | where
                                INFO | jvm 1 | 2009/05/04 22:30:40 | (
                                INFO | jvm 1 | 2009/05/04 22:30:40 | states0_.state is not null
                                INFO | jvm 1 | 2009/05/04 22:30:40 | )
                                INFO | jvm 1 | 2009/05/04 22:30:40 | and states0_.sID<53
                                INFO | jvm 1 | 2009/05/04 22:30:40 | order by
                                INFO | jvm 1 | 2009/05/04 22:30:40 | states0_.state
                                INFO | jvm 1 | 2009/05/04 22:30:40 | 22:30:40,178 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: text/html; charset=UTF-8
                                INFO | jvm 1 | 2009/05/04 22:30:40 | 22:30:40,788 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/s/3_3_0.GAcss/panel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:30:40 | 22:30:40,788 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/s/3_3_0.GAcss/panel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:30:41 | 22:30:41,038 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/s/3_3_0.GAcss/toolBar.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:30:41 | 22:30:41,038 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/s/3_3_0.GAcss/toolBar.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:30:41 | 22:30:41,272 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.PrototypeScript
                                INFO | jvm 1 | 2009/05/04 22:30:41 | 22:30:41,460 DEBUG [BaseXMLFilter] Parsing html total time 1282ms
                                INFO | jvm 1 | 2009/05/04 22:30:41 | 22:30:41,460 DEBUG [BaseFilter] Finished request processing total time 1469ms for uri: /autoauctions/home.seam
                                INFO | jvm 1 | 2009/05/04 22:30:47 | 22:30:47,897 DEBUG [BaseFilter] Finished request processing total time 6625ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.PrototypeScript
                                INFO | jvm 1 | 2009/05/04 22:30:49 | 22:30:49,335 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.AjaxScript
                                INFO | jvm 1 | 2009/05/04 22:30:49 | 22:30:49,335 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.AjaxScript
                                INFO | jvm 1 | 2009/05/04 22:30:52 | 22:30:52,147 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/available.js
                                INFO | jvm 1 | 2009/05/04 22:30:52 | 22:30:52,147 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/available.js
                                INFO | jvm 1 | 2009/05/04 22:30:52 | 22:30:52,600 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/jquery/jquery.js
                                INFO | jvm 1 | 2009/05/04 22:30:52 | 22:30:52,600 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/jquery/jquery.js
                                INFO | jvm 1 | 2009/05/04 22:30:55 | 22:30:55,428 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/script/controlUtils.js
                                INFO | jvm 1 | 2009/05/04 22:30:55 | 22:30:55,428 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/script/controlUtils.js
                                INFO | jvm 1 | 2009/05/04 22:30:55 | 22:30:55,772 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/utils.js
                                INFO | jvm 1 | 2009/05/04 22:30:55 | 22:30:55,772 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/utils.js
                                INFO | jvm 1 | 2009/05/04 22:30:56 | 22:30:56,256 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/browser_info.js
                                INFO | jvm 1 | 2009/05/04 22:30:56 | 22:30:56,256 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/browser_info.js
                                INFO | jvm 1 | 2009/05/04 22:30:56 | 22:30:56,616 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/modalPanel.js
                                INFO | jvm 1 | 2009/05/04 22:30:56 | 22:30:56,616 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/modalPanel.js
                                INFO | jvm 1 | 2009/05/04 22:30:57 | 22:30:57,819 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/modalPanelBorders.js
                                INFO | jvm 1 | 2009/05/04 22:30:57 | 22:30:57,819 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/modalPanelBorders.js
                                INFO | jvm 1 | 2009/05/04 22:30:58 | 22:30:58,444 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/s/3_3_0.GAorg/richfaces/renderkit/html/css/modalPanel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:30:58 | 22:30:58,460 DEBUG [BaseFilter] Finished request processing total time 16ms for uri: /autoauctions/a4j/s/3_3_0.GAorg/richfaces/renderkit/html/css/modalPanel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:30:58 | 22:30:58,710 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.ImageCacheScript
                                INFO | jvm 1 | 2009/05/04 22:30:58 | 22:30:58,710 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.ajax4jsf.javascript.ImageCacheScript
                                INFO | jvm 1 | 2009/05/04 22:30:59 | 22:30:58,991 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:30 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/ajax4jsf/javascript/scripts/form.js
                                INFO | jvm 1 | 2009/05/04 22:30:59 | 22:30:58,991 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/ajax4jsf/javascript/scripts/form.js
                                INFO | jvm 1 | 2009/05/04 22:31:00 | 22:31:00,866 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAscripts/simpleTogglePanel.js
                                INFO | jvm 1 | 2009/05/04 22:31:00 | 22:31:00,866 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAscripts/simpleTogglePanel.js
                                INFO | jvm 1 | 2009/05/04 22:31:01 | 22:31:01,335 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/s/3_3_0.GAcss/simpleTogglePanel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:31:01 | 22:31:01,335 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/s/3_3_0.GAcss/simpleTogglePanel.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:31:01 | 22:31:01,772 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAscripts/comboboxUtils.js
                                INFO | jvm 1 | 2009/05/04 22:31:01 | 22:31:01,772 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAscripts/comboboxUtils.js
                                INFO | jvm 1 | 2009/05/04 22:31:02 | 22:31:02,475 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAscripts/combolist.js
                                INFO | jvm 1 | 2009/05/04 22:31:02 | 22:31:02,491 DEBUG [BaseFilter] Finished request processing total time 16ms for uri: /autoauctions/a4j/g/3_3_0.GAscripts/combolist.js
                                INFO | jvm 1 | 2009/05/04 22:31:03 | 22:31:03,381 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAscripts/combobox.js
                                INFO | jvm 1 | 2009/05/04 22:31:03 | 22:31:03,381 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAscripts/combobox.js
                                INFO | jvm 1 | 2009/05/04 22:31:04 | 22:31:04,381 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAscripts/comboboxstyles.js
                                INFO | jvm 1 | 2009/05/04 22:31:04 | 22:31:04,381 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAscripts/comboboxstyles.js
                                INFO | jvm 1 | 2009/05/04 22:31:04 | 22:31:04,788 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/s/3_3_0.GAcss/combobox.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:31:04 | 22:31:04,788 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/s/3_3_0.GAcss/combobox.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:31:05 | 22:31:05,163 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/events.js
                                INFO | jvm 1 | 2009/05/04 22:31:05 | 22:31:05,163 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/events.js
                                INFO | jvm 1 | 2009/05/04 22:31:05 | 22:31:05,522 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/json/json-dom.js
                                INFO | jvm 1 | 2009/05/04 22:31:05 | 22:31:05,522 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/json/json-dom.js
                                INFO | jvm 1 | 2009/05/04 22:31:06 | 22:31:06,147 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/scriptaculous/effects.js
                                INFO | jvm 1 | 2009/05/04 22:31:06 | 22:31:06,147 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/scriptaculous/effects.js
                                INFO | jvm 1 | 2009/05/04 22:31:07 | 22:31:07,772 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/JQuerySpinBtn.js
                                INFO | jvm 1 | 2009/05/04 22:31:07 | 22:31:07,772 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/JQuerySpinBtn.js
                                INFO | jvm 1 | 2009/05/04 22:31:08 | 22:31:08,366 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/calendar.js
                                INFO | jvm 1 | 2009/05/04 22:31:08 | 22:31:08,381 DEBUG [BaseFilter] Finished request processing total time 15ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/calendar.js
                                INFO | jvm 1 | 2009/05/04 22:31:12 | 22:31:12,006 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/s/3_3_0.GAorg/richfaces/renderkit/html/css/calendar.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:31:12 | 22:31:12,006 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/s/3_3_0.GAorg/richfaces/renderkit/html/css/calendar.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:31:12 | 22:31:12,553 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/data-table.js
                                INFO | jvm 1 | 2009/05/04 22:31:12 | 22:31:12,553 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/scripts/data-table.js
                                INFO | jvm 1 | 2009/05/04 22:31:13 | 22:31:13,038 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/s/3_3_0.GAcss/table.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:31:13 | 22:31:13,038 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/s/3_3_0.GAcss/table.xcss/DATB/eAF7sqpgb-jyGdIAFrMEaw__
                                INFO | jvm 1 | 2009/05/04 22:31:13 | 22:31:13,397 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/css/msg.css
                                INFO | jvm 1 | 2009/05/04 22:31:13 | 22:31:13,397 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/css/msg.css
                                INFO | jvm 1 | 2009/05/04 22:31:13 | 22:31:13,756 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/css/msgs.css
                                INFO | jvm 1 | 2009/05/04 22:31:13 | 22:31:13,756 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/css/msgs.css
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,053 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/stylesheet/theme.css
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,053 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,053 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,053 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,053 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: text/css
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,053 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,053 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/stylesheet/theme.css
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,381 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/gsalogo.gif
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,381 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,381 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,381 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,381 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,381 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,381 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/gsalogo.gif
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,381 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAimages/spacer.gif
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,381 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAimages/spacer.gif
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/usaflag1.gif
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/usaflag1.gif
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/usaflag2.gif
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:14 | 22:31:14,631 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/usaflag2.gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/Home.gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/Home.gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/login2.gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:14,991 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/login2.gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,319 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/Calendar.gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,319 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,319 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,319 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,319 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,319 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,319 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/Calendar.gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,553 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/FindVehicle.gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,553 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,553 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,553 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,553 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,553 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,553 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/FindVehicle.gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,881 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/Search.gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,881 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,881 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,881 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,881 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,881 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:15 | 22:31:15,881 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/Search.gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,194 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/FAQ.gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,210 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,210 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,210 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,210 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,210 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,210 DEBUG [BaseFilter] Finished request processing total time 16ms for uri: /autoauctions/img/FAQ.gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/login.gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/login.gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/tssearch.gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,506 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/tssearch.gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,756 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/images/spacer.gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,756 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/images/spacer.gif
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,975 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.GradientA/DATB/eAH7!!3Tj2v7mAAZZAV3
                                INFO | jvm 1 | 2009/05/04 22:31:16 | 22:31:16,975 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.GradientA/DATB/eAH7!!3Tj2v7mAAZZAV3
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,288 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/2005Cavalier.jpg
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,288 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,288 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,288 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: null
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,288 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/2005Cavalier.jpg
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,350 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/img/close.png
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,350 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,350 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,350 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,350 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/png
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,350 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,350 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/img/close.png
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/2004Impala.jpg
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/jpeg
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/2004Impala.jpg
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/2005TrailBlazer.jpg
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/jpeg
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:17 | 22:31:17,600 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/2005TrailBlazer.jpg
                                INFO | jvm 1 | 2009/05/04 22:31:18 | 22:31:18,491 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/2006ImpalaLTZ.jpg
                                INFO | jvm 1 | 2009/05/04 22:31:18 | 22:31:18,491 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:18 | 22:31:18,491 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:18 | 22:31:18,491 DEBUG [FilterServletResponseWrapper] Create ByteArrayServletOutputStream for buffer servlet output
                                INFO | jvm 1 | 2009/05/04 22:31:18 | 22:31:18,491 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: image/jpeg
                                INFO | jvm 1 | 2009/05/04 22:31:18 | 22:31:18,491 DEBUG [BaseXMLFilter] Parser not have support for the such content type, send response as-is
                                INFO | jvm 1 | 2009/05/04 22:31:18 | 22:31:18,491 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/2006ImpalaLTZ.jpg
                                INFO | jvm 1 | 2009/05/04 22:31:20 | 22:31:20,163 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/images/bg_shadow.png
                                INFO | jvm 1 | 2009/05/04 22:31:20 | 22:31:20,178 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg/richfaces/renderkit/html/images/bg_shadow.png
                                INFO | jvm 1 | 2009/05/04 22:31:20 | 22:31:20,366 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.iconimages.CalendarIcon/DATB/eAH7cW0fw6znAA8XBA4_
                                INFO | jvm 1 | 2009/05/04 22:31:20 | 22:31:20,366 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.iconimages.CalendarIcon/DATB/eAH7cW0fw6znAA8XBA4_
                                INFO | jvm 1 | 2009/05/04 22:31:23 | 22:31:23,616 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.iconimages.CalendarSeparator/DATB/eAFjYGAAAAADAAE_
                                INFO | jvm 1 | 2009/05/04 22:31:23 | 22:31:23,616 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.iconimages.CalendarSeparator/DATB/eAFjYGAAAAADAAE_
                                INFO | jvm 1 | 2009/05/04 22:31:24 | 22:31:24,350 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.images.SpinnerButtonGradient/DATB/eAH7!!3Tj2v7mAAZZAV3
                                INFO | jvm 1 | 2009/05/04 22:31:24 | 22:31:24,350 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.images.SpinnerButtonGradient/DATB/eAH7!!3Tj2v7mAAZZAV3
                                INFO | jvm 1 | 2009/05/04 22:31:24 | 22:31:24,350 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.images.ComboBoxArrowImage/DATB/eAFjYGD4f-!Y!!!!ARNrBaE_
                                INFO | jvm 1 | 2009/05/04 22:31:24 | 22:31:24,350 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/a4j/g/3_3_0.GAorg.richfaces.renderkit.html.images.ComboBoxArrowImage/DATB/eAFjYGD4f-!Y!!!!ARNrBaE_
                                INFO | jvm 1 | 2009/05/04 22:31:24 | 22:31:24,663 DEBUG [BaseFilter] Filter start request processing at 5/4/09 10:31 PM for uri: /autoauctions/2005Cavalier.jpg
                                INFO | jvm 1 | 2009/05/04 22:31:24 | 22:31:24,663 DEBUG [BaseFilter] Filter request output to XML
                                INFO | jvm 1 | 2009/05/04 22:31:24 | 22:31:24,663 DEBUG [BaseXMLFilter] XML filter service start processing request
                                INFO | jvm 1 | 2009/05/04 22:31:24 | 22:31:24,663 DEBUG [BaseXMLFilter] create HTML/XML parser for content type: null
                                INFO | jvm 1 | 2009/05/04 22:31:24 | 22:31:24,663 DEBUG [BaseFilter] Finished request processing total time 0ms for uri: /autoauctions/2005Cavalier.jpg

                                • 12. Re: Seam/Richfaces home page loading slow
                                  nbelaevski

                                  The idea was to compare time of static and dynamic resources serving, but this log is not very helpful :(. Can you please:

                                  1. Clear apache access log
                                  2. Clear browser cache
                                  3. Configure httpd.conf to log request processing time - add %D to LogFormat used. Another option - use "Net" tab of firebug to track loading time.
                                  4. Navigate to the page that contains jQuery served using resources framework, record results
                                  5. Clear browser cache
                                  6. Navigate to the page that contains the same jQuery, but served as static resource, record time.

                                  Post time values recorded here.

                                  This: https://www.jboss.org/community/docs/DOC-13329 described how you configure Maven plugin in order to build aggregate statical resources for scripts and styles used. Check this also: https://jira.jboss.org/jira/browse/RF-6256.

                                  Also, you can switch compression for styles/scripts off and see whether compressor works long time. Note: compressed files contents is cached, so subsequent requests will be served much faster than an initial one - you have to restart application/server in order to clear served resources cache.

                                  • 13. Re: Seam/Richfaces home page loading slow
                                    pramod_bs

                                    First of all let me thank you for taking time to look into my issue. This means a lot to me and I can understand you have a busy schedule.

                                    My environment is:
                                    JBoss 4.2.1
                                    Richfaces 3.3
                                    Seam 2.1

                                    As advised by you I am trying to build static resources. I am new to maven and is there any example that I can use to build this. I am not sure how I can use maven with Seamand Richfaces. I searched on the Internet too.

                                    • 14. Re: Seam/Richfaces home page loading slow
                                      nbelaevski
                                      1 2 Previous Next