Forums de discussion

Strange liferay state ?

Aleksander Filipowicz, modifié il y a 11 années.

Strange liferay state ?

New Member Publications: 10 Date d'inscription: 02/04/13 Publications récentes
Hello!

We're having some problems running our portlet on liferay 6.0.5-Tomcat bundle. Sometimes, very randomly and quite rarely, the portlet enters a state where it refuses to load new pages.
We have not managed to reproduce this problem, it occurs when you least expect it.
When in this state, no matter what you do, click a link or button, the page you're currently on just reloads. The links/buttons are <h:commandButton> JSF components.
All logged in users on our application are affected by this problem. The only remedy is to restart the tomcat server.

Since the url stays the same no matter what we do during the state we suspect the error lies not in our portlet but further down in the Liferay stack.
This is what the url looks like.
http://localhost:8080/en/web/nyps/nyps-web-3.0?_1_WAR_tvv_nyps_web_INSTANCE_6qKQ__facesViewIdRender=%2FmyApplications.xhtml&amp;p_auth=hF25ADb3&amp;p_p_col_count=1&amp;p_p_col_id=column-1&amp;p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=1&amp;p_p_mode=view&amp;p_p_state=normal

If we, during this abnormal state, manually change the myApplications.xhtml in the url into any other xhtml file it loads normally. It is then stuck on that newly loaded page.

According to jvm status tools, such as jconsole, we can see no significant difference between a running service and one that has entered the error state.
This problem occurs both on windows and linux environments.
Anyone has any idea what might be wrong ?

Thanks in advance!
-Aleksander
thumbnail
Neil Griffin, modifié il y a 11 années.

RE: Strange liferay state ?

Liferay Legend Publications: 2655 Date d'inscription: 27/07/05 Publications récentes
Is the URL the same in the normal state and the abnormal state? Or is the URL different in the abnormal state?
Aleksander Filipowicz, modifié il y a 11 années.

RE: Strange liferay state ?

New Member Publications: 10 Date d'inscription: 02/04/13 Publications récentes
The URL is the same in normal and abnormal state.
In abnormal state it doesn't change if we click on links or buttons. It remains static.
In normal state the portion of the URL which contains the xhtml file name changes. This part of the URL -> (...facesViewIdRender=%2FoldApplicationSearchResults.xhtml)
thumbnail
Neil Griffin, modifié il y a 11 années.

RE: Strange liferay state ?

Liferay Legend Publications: 2655 Date d'inscription: 27/07/05 Publications récentes
Hi Aleksander,

When you get a chance, please paste the XHTML that contains your h:commandButton.

Thanks,

Neil
Aleksander Filipowicz, modifié il y a 11 années.

RE: Strange liferay state ?

New Member Publications: 10 Date d'inscription: 02/04/13 Publications récentes
Hi Neil,
Here's the xhtml file we use for our navigation menu:

<!--?xml version="1.0" encoding="UTF-8"?-->

<ui:composition xmlns:c="http://java.sun.com/jsp/jstl/core" xmlns:f="http://java.sun.com/jsf/core" xmlns:h="http://java.sun.com/jsf/html" xmlns:pcc="http://java.sun.com/jsf/composite/pcc" xmlns:ui="http://java.sun.com/jsf/facelets">


    <script src="js/jquery-ui.min.js"></script>
    <div id="sidebar1">
        <h:panelgroup layout="block" rendered="#{fp.displayMode!='print'}">
            <div class="nav-menu nav-menu-style-1">
                <h2><a href="">#{i18nFaces.menu}</a></h2>
                <h:form>
                    <ul class="layouts level-1">
                        <li class="">
                            <h:commandbutton id="myApplications" value="#{i18nFaces.myApplications}" action="myApplications" onclick="return showSaveDialog()" />
                        </li>
                        <li class="">
                            <h:commandbutton id="newAppWizard" value="#{i18nFaces.createNewApplication}" action="newAppWizard" onclick="return showSaveDialog()" />
                        </li>
                        
                        <li class="">
                            <h:commandbutton id="oldApplicationSearch" value="#{i18nFaces.createPayApplication_basedOnExternal}" action="oldApplicationSearch" onclick="return showSaveDialog()" />
                        </li>
                       
                        <li class="">
                            <h:commandbutton id="myDetails" value="#{i18nFaces.navigationMyDetails}" action="myDetails" onclick="return showSaveDialog()" />
                        </li>

                    </ul>
                </h:form>
            </div>
        </h:panelgroup>

        <h:panelgroup layout="block" rendered="#{fp.displayMode=='print'}">
            <div class="nav-menu nav-menu-style-1">
                <h2>
                    Meny
                </h2>
                <h:form>
                    <ul class="layouts level-1">
                        <li class="">
                            <h:commandbutton value="#{i18nFaces.print_to_application}" action="#{fp.closePDFView}">
                            </h:commandbutton>
                        </li>

                    </ul>
                </h:form>
            </div>
        </h:panelgroup>

    </div>
</ui:composition>



Thanks,
Aleksander
thumbnail
Neil Griffin, modifié il y a 11 années.

RE: Strange liferay state ?

Liferay Legend Publications: 2655 Date d'inscription: 27/07/05 Publications récentes
Hi Aleksander,

Which is the h:commandButton that fails? Also, what does the showSaveDialog() function do? Perhaps you could paste that too.

Thanks,

Neil
Aleksander Filipowicz, modifié il y a 11 années.

RE: Strange liferay state ?

New Member Publications: 10 Date d'inscription: 02/04/13 Publications récentes
All of the h:commandButton fail while in the abnormal state. When I click them I remain on the same page.
Also, when in the abnormal state there's nothing in the various log files that would indicate something is wrong.

The showSaveDialog() function just checks if anything has been changed in the application form the end-users are filling out and displays a dialog if so.
It looks like this:

function showSaveDialog(){
                if(isChanged){
                    return confirm("#{i18nFaces.form_status_wish_to_save}");
                }else{
                    return true;
                }
            }


/A
thumbnail
Neil Griffin, modifié il y a 11 années.

RE: Strange liferay state ?

Liferay Legend Publications: 2655 Date d'inscription: 27/07/05 Publications récentes
The action attribute of each h:commandButton has a value that seems to be using the implicit navigation-rule feature of JSF2. For example, are you expecting that action="myApplications" should navigate to myApplications.xhtml?
Aleksander Filipowicz, modifié il y a 11 années.

RE: Strange liferay state ?

New Member Publications: 10 Date d'inscription: 02/04/13 Publications récentes
Yes, action="myApplications" should navigate to myApplications.xhtml
thumbnail
Neil Griffin, modifié il y a 11 années.

RE: Strange liferay state ?

Liferay Legend Publications: 2655 Date d'inscription: 27/07/05 Publications récentes
OK, in order to debug what's going on during the abnormal state, I would recommend that you add the following to the portlet's log4j.properties file:
log4j.logger.com.liferay.faces.util.lifecycle.DebugPhaseListener=DEBUG
log4j.logger.com.liferay.faces.bridge.BridgePhaseActionImpl=DEBUG
log4j.logger.com.liferay.faces.bridge.BridgePhaseEventImpl=DEBUG
log4j.logger.com.liferay.faces.bridge.BridgePhaseRenderImpl=DEBUG
log4j.logger.com.liferay.faces.bridge.BridgePhaseResourceImpl=DEBUG
log4j.logger.com.liferay.faces.bridge.application.BridgeNavigationHandlerImpl=DEBUG
log4j.logger.com.liferay.faces.bridge.application.ViewHandlerImpl=DEBUG
log4j.logger.com.liferay.faces.bridge.container.liferay.PortletContainerLiferayImpl=DEBUG


Hopefully you will see something like this:

7:22:17,788 DEBUG [BridgePhaseActionImpl:51] ----------------------------------------------------------------------
17:22:17,789 DEBUG [BridgePhaseActionImpl:52] execute(ActionRequest, ActionResponse) portletName=[1]
17:22:17,790 DEBUG [PortletContainerLiferayImpl:118] Detected Liferay build number 6101
17:22:17,791 DEBUG [PortletContainerLiferayImpl:165] User-Agent requested URL=[http://localhost:8080/group/bridge-demos/jsf2?p_auth=WS1awgoe&p_p_id=1_WAR_jsf2portlet_INSTANCE_ABCD&p_p_lifecycle=1&p_p_state=normal&p_p_mode=view&p_p_col_id=column-1&p_p_col_count=1&_1_WAR_jsf2portlet_INSTANCE_ABCD__facesViewIdRender=%2Fviews%2Fconfirmation.xhtml]
17:22:17,796 DEBUG [DebugPhaseListener:64] BEFORE phaseId=[RESTORE_VIEW 1] viewId=[null]
17:22:17,797 DEBUG [ViewHandlerImpl:86] Restoring view for viewId=[/views/confirmation.xhtml]
17:22:17,798 DEBUG [ViewHandlerImpl:57] Creating view for viewId=[/views/confirmation.xhtml]
17:22:17,803 DEBUG [DebugPhaseListener:48] AFTER phaseId=[RESTORE_VIEW 1] viewId=[/views/confirmation.xhtml]
17:22:17,804 DEBUG [DebugPhaseListener:64] BEFORE phaseId=[APPLY_REQUEST_VALUES 2] viewId=[/views/confirmation.xhtml]
17:22:17,804 DEBUG [DebugPhaseListener:48] AFTER phaseId=[APPLY_REQUEST_VALUES 2] viewId=[/views/confirmation.xhtml]
17:22:17,805 DEBUG [DebugPhaseListener:64] BEFORE phaseId=[PROCESS_VALIDATIONS 3] viewId=[/views/confirmation.xhtml]
17:22:17,806 DEBUG [DebugPhaseListener:48] AFTER phaseId=[PROCESS_VALIDATIONS 3] viewId=[/views/confirmation.xhtml]
17:22:17,806 DEBUG [DebugPhaseListener:64] BEFORE phaseId=[UPDATE_MODEL_VALUES 4] viewId=[/views/confirmation.xhtml]
17:22:17,807 DEBUG [DebugPhaseListener:48] AFTER phaseId=[UPDATE_MODEL_VALUES 4] viewId=[/views/confirmation.xhtml]
17:22:17,807 DEBUG [DebugPhaseListener:64] BEFORE phaseId=[INVOKE_APPLICATION 5] viewId=[/views/confirmation.xhtml]
17:22:17,808 DEBUG [BridgeNavigationHandlerImpl:59] fromAction=[/views/portletViewMode.xhtml] outcome=[/views/portletViewMode.xhtml]
17:22:17,809 DEBUG [ViewHandlerImpl:57] Creating view for viewId=[/views/portletViewMode.xhtml]
17:22:17,810 DEBUG [DebugPhaseListener:48] AFTER phaseId=[INVOKE_APPLICATION 5] viewId=[/views/portletViewMode.xhtml]
17:22:17,825 DEBUG [BridgePhaseRenderImpl:73] ----------------------------------------------------------------------
17:22:17,827 DEBUG [BridgePhaseRenderImpl:74] execute(RenderRequest, RenderResponse) portletName=[1] portletMode=[view]
17:22:17,827 DEBUG [PortletContainerLiferayImpl:118] Detected Liferay build number 6101
17:22:17,828 DEBUG [PortletContainerLiferayImpl:165] User-Agent requested URL=[http://localhost:8080/group/bridge-demos/jsf2?p_auth=WS1awgoe&p_p_id=1_WAR_jsf2portlet_INSTANCE_ABCD&p_p_lifecycle=1&p_p_state=normal&p_p_mode=view&p_p_col_id=column-1&p_p_col_count=1&_1_WAR_jsf2portlet_INSTANCE_ABCD__facesViewIdRender=%2Fviews%2Fconfirmation.xhtml]
17:22:17,842 DEBUG [BridgeRequestScopeImpl:246] restoreState(facesContext)
17:22:17,842 DEBUG [BridgeRequestScopeImpl:272] Restored viewId=[/views/portletViewMode.xhtml] uiViewRoot=[com.liferay.faces.bridge.component.UIViewRootBridgeImpl@5c86201e]
17:22:17,843 DEBUG [BridgeRequestScopeImpl:299] Did not restore any facesMessages
17:22:17,844 DEBUG [BridgeRequestScopeImpl:332] Restored non-excluded request attributes
17:22:17,844 DEBUG [BridgePhaseRenderImpl:153] portletName=[1] facesLifecycleExecuted=[true]
17:22:17,845 DEBUG [BridgePhaseRenderImpl:226] Executing Faces render
17:22:17,846 DEBUG [DebugPhaseListener:64] BEFORE phaseId=[RENDER_RESPONSE 6] viewId=[/views/portletViewMode.xhtml]
17:22:17,907 DEBUG [DebugPhaseListener:48] AFTER phaseId=[RENDER_RESPONSE 6] viewId=[/views/portletViewMode.xhtml]
17:22:17,909 DEBUG [BridgePhaseRenderImpl:97] ----------------------------------------------------------------------

It will cause the log file to get quite large, but you need to see what Liferay Faces Bridge is doing when you click on the h:commandButton...
Aleksander Filipowicz, modifié il y a 11 années.

RE: Strange liferay state ?

New Member Publications: 10 Date d'inscription: 02/04/13 Publications récentes
Thanks Neil!

I'll add this to my log4j.properties and we'll see if something useful appears in the log :-)
Unfortunately we don't have any way to force the abnormal state to occur so it might take some time before I have some log printouts.

Best regards,
Aleksander
Aleksander Filipowicz, modifié il y a 10 années.

RE: Strange liferay state ?

New Member Publications: 10 Date d'inscription: 02/04/13 Publications récentes
Hello,

The abnormal state has occured once more. Here's an excerpt of the log when we click a h:commandbutton in our navigation menu.

13:52:25.130 [http-10080-7] INFO  se.tvv.nypsweb.util.DBUtil  - entering create connection for oracleNypsWebIipax
13:52:25.130 [http-10080-7] INFO  se.tvv.nypsweb.util.DBUtil  - leaving create connection for oracleNypsWebIipax
13:52:25.220 [http-10080-7] INFO  se.tvv.nypsweb.util.DBUtil  - entering close connection for oracleNypsWebIipax
13:52:25.220 [http-10080-7] INFO  se.tvv.nypsweb.util.DBUtil  - Clear memory
13:52:25.220 [http-10080-7] INFO  se.tvv.nypsweb.util.DBUtil  - leaving close connection for oracleNypsWebIipax
13:52:25,224 DEBUG [BridgePhaseRenderImpl:39] ----------------------------------------------------------------------
13:52:25,285 INFO  [PortalImpl:3812] Current URL /sv/web/nyps/js/jquery-ui.min.js generates exception: null
13:52:25,286 INFO  [PortalImpl:3824]
13:52:25,448 INFO  [PortalImpl:3812] Current URL /sv/web/nyps/js/jquery-ui.min.js generates exception: null
13:52:25,449 INFO  [PortalImpl:3824]
13:52:50,650 INFO  [TimeoutFilter:36] entering doFilter
13:52:50,650 INFO  [TimeoutFilter:39] filtering servlet request
13:52:50,650 INFO  [TimeoutFilter:47] about to control timeout
13:52:50,650 INFO  [TimeoutFilter:55] http session is valid
13:52:50,659 DEBUG [BridgePhaseActionImpl:39] ----------------------------------------------------------------------
13:52:50,660 DEBUG [BridgePhaseActionImpl:53] execute(ActionRequest, ActionResponse) portletName=[1]
13:52:50,662 DEBUG [PortletContainerLiferayImpl:115] Detected Liferay build number 6005
13:52:50,663 DEBUG [PortletContainerLiferayImpl:161] User-Agent requested URL=[http://themisto.tillvaxtverket.se:10080/sv/web/nyps
/nyps-web-3.0?_1_WAR_tvv_nyps_web_INSTANCE_6qKQ__facesViewIdRender=%2FmyApplications.xhtml&amp;p_auth=kcbsZP7g&amp;p_p_col_count=1&amp;p_p_col
_id=column-1&amp;p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=1&amp;p_p_mode=view&amp;p_p_state=normal]
13:52:50,664 DEBUG [ViewHandlerImpl:79] Restoring view for viewId=[/myApplications.xhtml]
13:52:50,665 DEBUG [ViewHandlerImpl:54] Creating view for viewId=[/myApplications.xhtml]
13:52:50.668 [http-10080-7] DEBUG s.t.n.s.a.EIDPhaseListener  - afterPhase
13:52:50.668 [http-10080-7] DEBUG s.t.n.s.a.EIDPhaseListener  - found user in session: 199008199391
13:52:50,679 DEBUG [BridgePhaseRenderImpl:39] ----------------------------------------------------------------------
13:52:50,680 DEBUG [BridgePhaseRenderImpl:72] execute(RenderRequest, RenderResponse) portletName=[1] portletMode=[view]
13:52:50,683 DEBUG [PortletContainerLiferayImpl:115] Detected Liferay build number 6005
13:52:50,684 DEBUG [PortletContainerLiferayImpl:161] User-Agent requested URL=[http://themisto.tillvaxtverket.se:10080/sv/web/nyps
/nyps-web-3.0?_1_WAR_tvv_nyps_web_INSTANCE_6qKQ__facesViewIdRender=%2FmyApplications.xhtml&amp;p_auth=kcbsZP7g&amp;p_p_col_count=1&amp;p_p_col
_id=column-1&amp;p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=1&amp;p_p_mode=view&amp;p_p_state=normal]
13:52:50,685 DEBUG [BridgePhaseRenderImpl:192] portletName=[1] facesLifecycleAlreadyExecuted=[true]
13:52:50,686 DEBUG [BridgeNavigationHandlerImpl:130] fromPortletMode=[view] toPortletMode=[view]
13:52:50,687 DEBUG [BridgePhaseRenderImpl:39] Executing Faces render
13:52:50,689 DEBUG [PortletContainerLiferayImpl:254] Copied parameter to portletURL name=[_facesViewIdRender] value=[/myApplicatio
ns.xhtml]
13:52:50,690 DEBUG [PortletContainerLiferayImpl:254] Copied parameter to portletURL name=[_jsfBridgeAjax] value=[true]
13:52:50,691 DEBUG [PortletContainerLiferayImpl:254] Copied parameter to portletURL name=[_facesViewIdResource] value=[/myApplicat
ions.xhtml]
13:52:50.693 [http-10080-7] DEBUG s.t.n.a.MyApplicationsBackingBean  - clearing fileUploadBean
13:52:50.693 [http-10080-7] INFO  se.tvv.nypsweb.util.DBUtil  - entering create connection for oracleNypsWebIipax
13:52:50.693 [http-10080-7] INFO  se.tvv.nypsweb.util.DBUtil  - leaving create connection for oracleNypsWebIipax
13:52:50.775 [http-10080-7] INFO  se.tvv.nypsweb.util.DBUtil  - entering close connection for oracleNypsWebIipax
13:52:50.775 [http-10080-7] INFO  se.tvv.nypsweb.util.DBUtil  - Clear memory
13:52:50.775 [http-10080-7] INFO  se.tvv.nypsweb.util.DBUtil  - leaving close connection for oracleNypsWebIipax
13:52:50,778 DEBUG [BridgePhaseRenderImpl:39] ----------------------------------------------------------------------
13:52:50,881 INFO  [PortalImpl:3812] Current URL /sv/web/nyps/js/jquery-ui.min.js generates exception: null
13:52:50,882 INFO  [PortalImpl:3824]
13:52:51,033 INFO  [PortalImpl:3812] Current URL /sv/web/nyps/js/jquery-ui.min.js generates exception: null
13:52:51,034 INFO  [PortalImpl:3824]


And here is an excerpt of the log from a working environment when doing excactly the same operation as above:
13:35:47.645 [http-9080-10] INFO  se.tvv.nypsweb.action.LoginBean  - invalidated session
13:35:47,645 DEBUG [BridgeNavigationHandlerImpl:59] fromAction=[#{loginBean.logout}] outcome=[loggedOut]
13:35:47,661 DEBUG [ViewHandlerImpl:57] Creating view for viewId=[/loggedOut.xhtml]
13:35:47,679 DEBUG [BridgePhaseRenderImpl:73] ----------------------------------------------------------------------
13:35:47,679 DEBUG [BridgePhaseRenderImpl:74] execute(RenderRequest, RenderResponse) portletName=[1] portletMode=[view]
13:35:47,680 DEBUG [PortletContainerLiferayImpl:115] Detected Liferay build number 6005
13:35:47,681 DEBUG [PortletContainerLiferayImpl:162] User-Agent requested URL=[http://themisto.tillvaxtverket.se:9080/sv/web/nyps/nyps-web-3.0?p_a
uth=Bwpy0LrK&amp;p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=1&amp;p_p_state=normal&amp;p_p_mode=view&amp;p_p_col_id=column-1&amp;p_p_col_count=1&amp;_1_WAR_tvv
_nyps_web_INSTANCE_6qKQ__facesViewIdRender=%2FmyApplications.xhtml]
13:35:47,683 DEBUG [BridgePhaseRenderImpl:153] portletName=[1] facesLifecycleExecuted=[true]
13:35:47,683 DEBUG [BridgePhaseRenderImpl:226] Executing Faces render
13:35:47,693 DEBUG [BridgePhaseRenderImpl:97] ----------------------------------------------------------------------
13:36:58,794 INFO  [TimeoutFilter:36] entering doFilter
13:36:58,794 INFO  [TimeoutFilter:39] filtering servlet request
13:36:58,794 INFO  [TimeoutFilter:47] about to control timeout
13:36:58,794 INFO  [TimeoutFilter:55] http session is valid
13:36:58,808 DEBUG [BridgePhaseActionImpl:50] ----------------------------------------------------------------------
13:36:58,809 DEBUG [BridgePhaseActionImpl:51] execute(ActionRequest, ActionResponse) portletName=[1]
13:36:58,809 DEBUG [PortletContainerLiferayImpl:115] Detected Liferay build number 6005
13:36:58,810 DEBUG [PortletContainerLiferayImpl:162] User-Agent requested URL=[http://themisto.tillvaxtverket.se:9080/sv/web/nyps/nyps-web-3.0?p_a
uth=Cx06Vlcj&amp;p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=1&amp;p_p_state=normal&amp;p_p_mode=view&amp;p_p_col_id=column-1&amp;p_p_col_count=1&amp;_1_WAR_tvv
_nyps_web_INSTANCE_6qKQ__facesViewIdRender=%2FmyApplications.xhtml]
13:36:58,811 DEBUG [ViewHandlerImpl:86] Restoring view for viewId=[/myApplications.xhtml]
13:36:58,812 DEBUG [ViewHandlerImpl:57] Creating view for viewId=[/myApplications.xhtml]
13:36:58.824 [http-9080-9] DEBUG s.t.n.s.a.EIDPhaseListener  - afterPhase
13:36:58.824 [http-9080-9] DEBUG s.t.n.s.a.EIDPhaseListener  - found user in session: 199008199391
13:36:58,825 DEBUG [BridgeNavigationHandlerImpl:59] fromAction=[myDetails] outcome=[myDetails]
13:36:58,839 DEBUG [ViewHandlerImpl:57] Creating view for viewId=[/myDetails.xhtml]
13:36:58,943 DEBUG [BridgePhaseRenderImpl:73] ----------------------------------------------------------------------
13:36:58,944 DEBUG [BridgePhaseRenderImpl:74] execute(RenderRequest, RenderResponse) portletName=[1] portletMode=[view]
13:36:58,945 DEBUG [PortletContainerLiferayImpl:115] Detected Liferay build number 6005
13:36:58,946 DEBUG [PortletContainerLiferayImpl:162] User-Agent requested URL=[http://themisto.tillvaxtverket.se:9080/sv/web/nyps/nyps-web-3.0?p_a
uth=Cx06Vlcj&amp;p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=1&amp;p_p_state=normal&amp;p_p_mode=view&amp;p_p_col_id=column-1&amp;p_p_col_count=1&amp;_1_WAR_tvv
_nyps_web_INSTANCE_6qKQ__facesViewIdRender=%2FmyApplications.xhtml]
13:36:58,947 DEBUG [BridgePhaseRenderImpl:153] portletName=[1] facesLifecycleExecuted=[true]
13:36:58,948 DEBUG [BridgePhaseRenderImpl:226] Executing Faces render
13:36:59,306 ERROR [BaseURLNonEncodedStringImpl:208] Invalid name=value pair=[amp;v=3.0.1] in URL=[http://themisto.tillvaxtverket.se:9080/sv/web/n
yps/nyps-web-3.0?p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=2&amp;p_p_state=normal&amp;p_p_mode=view&amp;p_p_cacheability=cacheLevelPage&amp;p_p_col_id
=column-1&amp;p_p_col_count=1&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_javax.faces.resource=primefaces.css&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_ln=primefaces&amp;am
p;v=3.0.1]
13:36:59,313 ERROR [BaseURLNonEncodedStringImpl:208] Invalid name=value pair=[amp;v=3.0.1] in URL=[http://themisto.tillvaxtverket.se:9080/sv/web/n
yps/nyps-web-3.0?p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=2&amp;p_p_state=normal&amp;p_p_mode=view&amp;p_p_cacheability=cacheLevelPage&amp;p_p_col_id
=column-1&amp;p_p_col_count=1&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_javax.faces.resource=jquery%2Fjquery.js&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_ln=primeface
s&amp;v=3.0.1]
13:36:59,315 ERROR [BaseURLNonEncodedStringImpl:208] Invalid name=value pair=[amp;v=3.0.1] in URL=[http://themisto.tillvaxtverket.se:9080/sv/web/n
yps/nyps-web-3.0?p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=2&amp;p_p_state=normal&amp;p_p_mode=view&amp;p_p_cacheability=cacheLevelPage&amp;p_p_col_id
=column-1&amp;p_p_col_count=1&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_javax.faces.resource=primefaces.js&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_ln=primefaces&amp;
;v=3.0.1]
13:36:59.321 [http-9080-9] INFO  se.tvv.nypsweb.util.DBUtil  - entering create connection for oracleNypsWebIipax
13:36:59.321 [http-9080-9] INFO  se.tvv.nypsweb.util.DBUtil  - leaving create connection for oracleNypsWebIipax
13:36:59.384 [http-9080-9] INFO  se.tvv.nypsweb.util.DBUtil  - entering create connection for oracleNypsWebIipax
13:36:59.408 [http-9080-9] INFO  se.tvv.nypsweb.util.DBUtil  - leaving create connection for oracleNypsWebIipax
13:36:59.543 [http-9080-9] INFO  se.tvv.nypsweb.util.DBUtil  - entering close connection for oracleNypsWebIipax
13:36:59.543 [http-9080-9] INFO  se.tvv.nypsweb.util.DBUtil  - Clear memory
13:36:59.543 [http-9080-9] INFO  se.tvv.nypsweb.util.DBUtil  - leaving close connection for oracleNypsWebIipax
13:36:59.544 [http-9080-9] INFO  se.tvv.nypsweb.util.DBUtil  - entering create connection for oracleNypsWebIipax
13:36:59.544 [http-9080-9] INFO  se.tvv.nypsweb.util.DBUtil  - leaving create connection for oracleNypsWebIipax
13:36:59.712 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_firstname.help
13:36:59.712 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_firstname.help
13:36:59.716 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_lastname.help
13:36:59.717 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_lastname.help
13:36:59.718 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_civicnumber.help
13:36:59.718 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_civicnumber.help
13:36:59.720 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_phonenumber.help
13:36:59.720 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_phonenumber.help
13:36:59.724 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_email.help
13:36:59.724 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_email.help
13:36:59.726 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_company_name.help
13:36:59.726 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_company_name.help
13:36:59.730 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_company_legalform.help
13:36:59.730 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_company_legalform.help
13:36:59.741 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_company_homepage.help
13:36:59.741 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_company_homepage.help
13:36:59.743 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_company_country.help
13:36:59.743 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_company_country.help
13:36:59.746 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_company_number.help
13:36:59.746 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_company_number.help
13:36:59.748 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_name.help
13:36:59.748 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_name.help
13:36:59.750 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_number.help
13:36:59.751 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_number.help
13:36:59.762 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_address.help
13:36:59.762 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_address.help
13:36:59.766 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_visit_adress.h
elp
13:36:59.766 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_visit_adress.h
elp
13:36:59.768 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_zip.help
13:36:59.769 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_zip.help
13:36:59.771 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_city.help
13:36:59.771 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_workplace_city.help
13:36:59.775 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_worklpace_county.help
13:36:59.775 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_worklpace_county.help
13:36:59.779 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_worklpace_municipality.h
elp
13:36:59.779 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_worklpace_municipality.h
elp
13:36:59.783 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_worklpace_parish.help
13:36:59.784 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_worklpace_parish.help
13:36:59.787 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: wp_trade_code.help
13:36:59.787 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: wp_trade_code.help
13:36:59.798 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_contact.help
13:36:59.798 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_contact.help
13:36:59.800 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_contact_phonenumber.help
13:36:59.800 [http-9080-9] INFO  se.tvv.nypsweb.util.PropertyUtil  - found value: null in context.xml form key: myDetails_contact_phonenumber.help
13:36:59,810 DEBUG [BridgePhaseRenderImpl:97] ----------------------------------------------------------------------
13:36:59,914 INFO  [TimeoutFilter:36] entering doFilter
13:36:59,915 INFO  [TimeoutFilter:39] filtering servlet request
13:36:59,915 INFO  [TimeoutFilter:47] about to control timeout
13:36:59,915 INFO  [TimeoutFilter:55] http session is valid
13:36:59,920 INFO  [TimeoutFilter:36] entering doFilter
13:36:59,921 INFO  [TimeoutFilter:39] filtering servlet request
13:36:59,921 INFO  [TimeoutFilter:47] about to control timeout
13:36:59,921 INFO  [TimeoutFilter:55] http session is valid
13:36:59,951 INFO  [TimeoutFilter:36] entering doFilter
13:36:59,951 INFO  [TimeoutFilter:39] filtering servlet request
13:36:59,951 INFO  [TimeoutFilter:47] about to control timeout
13:36:59,951 INFO  [TimeoutFilter:55] http session is valid
13:36:59,974 INFO  [TimeoutFilter:36] entering doFilter
13:36:59,974 INFO  [TimeoutFilter:39] filtering servlet request
13:36:59,974 INFO  [TimeoutFilter:47] about to control timeout
13:36:59,974 INFO  [TimeoutFilter:55] http session is valid
13:36:59,978 DEBUG [BridgePhaseResourceImpl:50] ----------------------------------------------------------------------
13:36:59,979 DEBUG [BridgePhaseResourceImpl:51] execute(ResourceRequest, ResourceResponse) portletName=[1]
13:36:59,980 DEBUG [PortletContainerLiferayImpl:115] Detected Liferay build number 6005
13:36:59,980 DEBUG [PortletContainerLiferayImpl:162] User-Agent requested URL=[http://themisto.tillvaxtverket.se:9080/sv/web/nyps/nyps-web-3.0?p_p
_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=2&amp;p_p_state=normal&amp;p_p_mode=view&amp;p_p_cacheability=cacheLevelPage&amp;p_p_col_id=column-1&amp;p_p_col_co
unt=1&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_javax.faces.resource=jsf.js&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_ln=javax.faces]
13:36:59,982 DEBUG [BridgePhaseResourceImpl:61] Detected JSF2 resource request
13:36:59,983 DEBUG [BridgePhaseResourceImpl:143] ----------------------------------------------------------------------
13:36:59,996 DEBUG [BridgePhaseResourceImpl:50] ----------------------------------------------------------------------
13:36:59,997 DEBUG [BridgePhaseResourceImpl:51] execute(ResourceRequest, ResourceResponse) portletName=[1]
13:36:59,997 DEBUG [PortletContainerLiferayImpl:115] Detected Liferay build number 6005
13:36:59,998 DEBUG [PortletContainerLiferayImpl:162] User-Agent requested URL=[http://themisto.tillvaxtverket.se:9080/sv/web/nyps/nyps-web-3.0?p_p
_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=2&amp;p_p_state=normal&amp;p_p_mode=view&amp;p_p_cacheability=cacheLevelPage&amp;p_p_col_id=column-1&amp;p_p_col_co
unt=1&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_javax.faces.resource=jquery%2Fjquery.js&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_ln=primefaces&amp;v=3.0.1]
13:36:59,999 DEBUG [BridgePhaseResourceImpl:61] Detected JSF2 resource request
13:37:00,002 DEBUG [BridgePhaseResourceImpl:50] ----------------------------------------------------------------------
13:37:00,003 DEBUG [BridgePhaseResourceImpl:143] ----------------------------------------------------------------------
13:37:00,003 DEBUG [BridgePhaseResourceImpl:51] execute(ResourceRequest, ResourceResponse) portletName=[1]
13:37:00,004 DEBUG [PortletContainerLiferayImpl:115] Detected Liferay build number 6005
13:37:00,005 DEBUG [PortletContainerLiferayImpl:162] User-Agent requested URL=[http://themisto.tillvaxtverket.se:9080/sv/web/nyps/nyps-web-3.0?p_p
_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=2&amp;p_p_state=normal&amp;p_p_mode=view&amp;p_p_cacheability=cacheLevelPage&amp;p_p_col_id=column-1&amp;p_p_col_co
unt=1&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_javax.faces.resource=primefaces.js&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_ln=primefaces&amp;v=3.0.1]
13:37:00,006 DEBUG [BridgePhaseResourceImpl:61] Detected JSF2 resource request
13:37:00,009 DEBUG [BridgePhaseResourceImpl:143] ----------------------------------------------------------------------
13:37:00,018 DEBUG [BridgePhaseResourceImpl:50] ----------------------------------------------------------------------
13:37:00,019 DEBUG [BridgePhaseResourceImpl:51] execute(ResourceRequest, ResourceResponse) portletName=[1]
13:37:00,020 DEBUG [PortletContainerLiferayImpl:115] Detected Liferay build number 6005
13:37:00,021 DEBUG [PortletContainerLiferayImpl:162] User-Agent requested URL=[http://themisto.tillvaxtverket.se:9080/sv/web/nyps/nyps-web-3.0?p_p
_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=2&amp;p_p_state=normal&amp;p_p_mode=view&amp;p_p_cacheability=cacheLevelPage&amp;p_p_col_id=column-1&amp;p_p_col_co
unt=1&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_javax.faces.resource=primefaces.css&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_ln=primefaces&amp;v=3.0.1]
13:37:00,023 DEBUG [BridgePhaseResourceImpl:61] Detected JSF2 resource request
13:37:00,030 DEBUG [BridgePhaseResourceImpl:143] ----------------------------------------------------------------------
13:37:00,053 INFO  [PortalImpl:3812] Current URL /sv/web/nyps/js/jquery-ui.min.js generates exception: null
13:37:00,053 INFO  [PortalImpl:3824]
13:37:00,229 INFO  [PortalImpl:3812] Current URL /sv/web/nyps/js/jquery-ui.min.js generates exception: null
13:37:00,230 INFO  [PortalImpl:3824]


Most notable change I can see is that the following lines are missing in the abnormal log.
13:36:58,825 DEBUG [BridgeNavigationHandlerImpl:59] fromAction=[myDetails] outcome=[myDetails]
13:36:58,839 DEBUG [ViewHandlerImpl:57] Creating view for viewId=[/myDetails.xhtml]


Best regards,
Aleksander
thumbnail
Neil Griffin, modifié il y a 10 années.

RE: Strange liferay state ?

Liferay Legend Publications: 2655 Date d'inscription: 27/07/05 Publications récentes
I noticed that in the abnormal log, the line numbers for ViewHanlderImpl are 79 and 54:

2113:52:50,664 DEBUG [ViewHandlerImpl:79] Restoring view for viewId=[/myApplications.xhtml]
2213:52:50,665 DEBUG [ViewHandlerImpl:54] Creating view for viewId=[/myApplications.xhtml]

And in the working/normal log they are 86 and 57:

2313:36:58,811 DEBUG [ViewHandlerImpl:86] Restoring view for viewId=[/myApplications.xhtml]
2413:36:58,812 DEBUG [ViewHandlerImpl:57] Creating view for viewId=[/myApplications.xhtml]

Are you certain that you are using the same version of Liferay Faces Bridge on both systems?

BTW, you are right to point out that the BridgeNavigationHandlerImpl logger is not found in the abnormal log. I was hoping that the loggers would reveal something like that. Now we have to figure out why the navigation rule doesn't fire.

Question -- when the abnormal state happens, could it possibly be because the user has waited a long time (possibly 30 minutes) after the portal page was initially rendered? I'm just wondering if we are facing a session expiration problem.
Aleksander Filipowicz, modifié il y a 10 années.

RE: Strange liferay state ?

New Member Publications: 10 Date d'inscription: 02/04/13 Publications récentes
You were right, there were some differences in the liferay faces bridge. I re-ran the same operation and this is the log from it:

10:36:00.850 [http-9080-1] INFO  se.tvv.nypsweb.util.DBUtil  - leaving create connection for oracleNypsWebIipax
10:36:01.083 [http-9080-1] DEBUG s.t.n.a.MyApplicationsBackingBean  - Application with wp_id: 2000000459 is updated with workplace id: 133411
10:36:01.100 [http-9080-1] INFO  se.tvv.nypsweb.util.DBUtil  - entering close connection for oracleNypsWebIipax
10:36:01.100 [http-9080-1] INFO  se.tvv.nypsweb.util.DBUtil  - Clear memory
10:36:01.100 [http-9080-1] INFO  se.tvv.nypsweb.util.DBUtil  - leaving close connection for oracleNypsWebIipax
10:36:01,144 DEBUG [BridgePhaseRenderImpl:39] ----------------------------------------------------------------------
10:36:01,358 INFO  [PortalImpl:3812] Current URL /sv/web/nyps/js/jquery-ui.min.js generates exception: null
10:36:01,359 INFO  [PortalImpl:3824]
10:36:30,909 INFO  [TimeoutFilter:36] entering doFilter
10:36:30,909 INFO  [TimeoutFilter:39] filtering servlet request
10:36:30,909 INFO  [TimeoutFilter:47] about to control timeout
10:36:30,910 INFO  [TimeoutFilter:55] http session is valid
10:36:30,944 DEBUG [BridgePhaseActionImpl:39] ----------------------------------------------------------------------
10:36:30,945 DEBUG [BridgePhaseActionImpl:53] execute(ActionRequest, ActionResponse) portletName=[1]
10:36:30,947 DEBUG [PortletContainerLiferayImpl:115] Detected Liferay build number 6005
10:36:30,948 DEBUG [PortletContainerLiferayImpl:161] User-Agent requested URL=[http://themisto.tillvaxtverket.se:9080/sv/web/nyps/nyps-web-3.0?_1_
WAR_tvv_nyps_web_INSTANCE_6qKQ__facesViewIdRender=%2FmyApplications.xhtml&amp;p_auth=1Kre5rKC&amp;p_p_col_count=1&amp;p_p_col_id=column-1&amp;p_p_id=1_WAR_tvv_nyp
s_web_INSTANCE_6qKQ&amp;p_p_lifecycle=1&amp;p_p_mode=view&amp;p_p_state=normal]
10:36:30,949 DEBUG [ViewHandlerImpl:79] Restoring view for viewId=[/myApplications.xhtml]
10:36:30,950 DEBUG [ViewHandlerImpl:54] Creating view for viewId=[/myApplications.xhtml]
10:36:30.963 [http-9080-1] DEBUG s.t.n.s.a.EIDPhaseListener  - afterPhase
10:36:30.964 [http-9080-1] DEBUG s.t.n.s.a.EIDPhaseListener  - found user in session: 199008199391
10:36:30,967 DEBUG [BridgeNavigationHandlerImpl:60] fromAction=[myDetails] outcome=[myDetails]
10:36:30,968 DEBUG [ViewHandlerImpl:54] Creating view for viewId=[/myDetails.xhtml]
10:36:30,994 DEBUG [BridgePhaseRenderImpl:39] ----------------------------------------------------------------------
10:36:30,995 DEBUG [BridgePhaseRenderImpl:72] execute(RenderRequest, RenderResponse) portletName=[1] portletMode=[view]
10:36:30,997 DEBUG [PortletContainerLiferayImpl:115] Detected Liferay build number 6005
10:36:30,998 DEBUG [PortletContainerLiferayImpl:161] User-Agent requested URL=[http://themisto.tillvaxtverket.se:9080/sv/web/nyps/nyps-web-3.0?_1_
WAR_tvv_nyps_web_INSTANCE_6qKQ__facesViewIdRender=%2FmyApplications.xhtml&amp;p_auth=1Kre5rKC&amp;p_p_col_count=1&amp;p_p_col_id=column-1&amp;p_p_id=1_WAR_tvv_nyp
s_web_INSTANCE_6qKQ&amp;p_p_lifecycle=1&amp;p_p_mode=view&amp;p_p_state=normal]
10:36:31,000 DEBUG [BridgePhaseRenderImpl:192] portletName=[1] facesLifecycleAlreadyExecuted=[true]
10:36:31,001 DEBUG [BridgeNavigationHandlerImpl:130] fromPortletMode=[view] toPortletMode=[view]
10:36:31,002 DEBUG [BridgePhaseRenderImpl:39] Executing Faces render
10:36:31,209 DEBUG [PortletContainerLiferayImpl:254] Copied parameter to portletURL name=[ln] value=[primefaces-aristo]
10:36:31,212 DEBUG [PortletContainerLiferayImpl:254] Copied parameter to portletURL name=[ln] value=[primefaces]
10:36:31,213 ERROR [BaseURLNonEncodedStringImpl:196] Invalid name=value pair=[amp;v=3.0.1] in URL=[http://themisto.tillvaxtverket.se:9080/sv/web/n
yps/nyps-web-3.0?_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_ln=primefaces&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_javax.faces.resource=primefaces.css&amp;p_p_col_cou
nt=1&amp;p_p_col_id=column-1&amp;p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=2&amp;v=3.0.1]
10:36:31,216 DEBUG [PortletContainerLiferayImpl:254] Copied parameter to portletURL name=[ln] value=[javax.faces]
10:36:31,220 DEBUG [PortletContainerLiferayImpl:254] Copied parameter to portletURL name=[ln] value=[primefaces]
10:36:31,222 ERROR [BaseURLNonEncodedStringImpl:196] Invalid name=value pair=[amp;v=3.0.1] in URL=[http://themisto.tillvaxtverket.se:9080/sv/web/n
yps/nyps-web-3.0?_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_ln=primefaces&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_javax.faces.resource=jquery%2Fjquery.js&amp;p_p_col
_count=1&amp;p_p_col_id=column-1&amp;p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=2&amp;v=3.0.1]
10:36:31,224 DEBUG [PortletContainerLiferayImpl:254] Copied parameter to portletURL name=[ln] value=[primefaces]
10:36:31,225 ERROR [BaseURLNonEncodedStringImpl:196] Invalid name=value pair=[amp;v=3.0.1] in URL=[http://themisto.tillvaxtverket.se:9080/sv/web/n
yps/nyps-web-3.0?_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_ln=primefaces&amp;_1_WAR_tvv_nyps_web_INSTANCE_6qKQ_javax.faces.resource=primefaces.js&amp;p_p_col_coun
t=1&amp;p_p_col_id=column-1&amp;p_p_id=1_WAR_tvv_nyps_web_INSTANCE_6qKQ&amp;p_p_lifecycle=2&amp;v=3.0.1]
10:36:31.230 [http-9080-1] INFO  se.tvv.nypsweb.util.DBUtil  - entering create connection for oracleNypsWebIipax
10:36:31.231 [http-9080-1] INFO  se.tvv.nypsweb.util.DBUtil  - leaving create connection for oracleNypsWebIipax
10:36:31.275 [http-9080-1] INFO  se.tvv.nypsweb.util.DBUtil  - entering create connection for oracleNypsWebIipax
10:36:31.300 [http-9080-1] INFO  se.tvv.nypsweb.util.DBUtil  - leaving create connection for oracleNypsWebIipax
10:36:31.306 [http-9080-1] INFO  se.tvv.nypsweb.util.DBUtil  - entering close connection for oracleNypsWebIipax
10:36:31.306 [http-9080-1] INFO  se.tvv.nypsweb.util.DBUtil  - Clear memory

Line numbers seems to be the same now.

I'm not sure it is a user session timeout problem since it affects all users that log on to our application. We have tried to make the session expire but the problem has not occured then.
thumbnail
Neil Griffin, modifié il y a 10 années.

RE: Strange liferay state ?

Liferay Legend Publications: 2655 Date d'inscription: 27/07/05 Publications récentes
OK, I understand that you are now using the same version of Liferay Faces Bridge in the normal and abnormal environments. But what version are you using?

I looked at version 3.1.0-ga1 and 3.1.1-ga2 of ViewHandlerImpl.java and neither of them have debug statements on line 54 or line 79.
Aleksander Filipowicz, modifié il y a 10 années.

RE: Strange liferay state ?

New Member Publications: 10 Date d'inscription: 02/04/13 Publications récentes
We're using this version of the liferay-faces bridge jar: liferay-faces-bridge-impl-3.0.0-BETA2.jar.
I'm not sure why we're using a beta version of the bridge. I've only been in this project for a few months.
Do you think this might be the cause of the problem ?
We're currently migrating to Liferay 6.1.1 and liferay faces bridge 3.1.1ga2, hoping it will solve our problem.
thumbnail
Neil Griffin, modifié il y a 10 années.

RE: Strange liferay state ?

Liferay Legend Publications: 2655 Date d'inscription: 27/07/05 Publications récentes
Hi Aleksander,

I don't know if upgrading to the General Availability (GA) production release JARs will fix the problem, but upgrading is a good thing because the beta versions are very old and were not certified as JSR 329 compliant.

Thanks,

Neil
thumbnail
Vernon Singleton, modifié il y a 10 années.

RE: Strange liferay state ?

Expert Publications: 315 Date d'inscription: 14/01/13 Publications récentes
HI Aleksander,

My git foo may not be so strong today, but:

$ line=54; pattern=Creat; file=bridge-impl/src/main/java/com/liferay/faces/bridge/application/ViewHandlerImpl.java; echo; git show-ref --tags | while read ct; do c=`echo $ct | cut -f1 -d" "`; t=`echo $ct | cut -f2 -d" "`; git show $c:$file | head -${line} | tail -1 | grep $pattern && echo "line number: $line from tag: $t commit: $c"; done

logger.debug("Creating view for viewId=[{0}]", viewId);
line number: 54 from tag: refs/tags/3.0.0-BETA1 commit: 7da8c59658e75b43e4c9cde62a82846483c9e3fa
logger.debug("Creating view for viewId=[{0}]", viewId);
line number: 54 from tag: refs/tags/3.0.0-BETA2 commit: 496134617fbc141e7ccc027bd071ab1d11e57f19
logger.debug("Creating view for viewId=[{0}]", viewId);
line number: 54 from tag: refs/tags/3.0.0-RC1 commit: 529e98cebe00a244256265bd72902844c46b3a00
logger.debug("Creating view for viewId=[{0}]", viewId);
line number: 54 from tag: refs/tags/3.1.0-BETA1 commit: 16bf8ef60a407bba2df89fa036d6e132eaf19825
logger.debug("Creating view for viewId=[{0}]", viewId);
line number: 54 from tag: refs/tags/3.1.0-BETA2 commit: 14770509cbca6ca0c73256bc4d31fe29893d2ed2
logger.debug("Creating view for viewId=[{0}]", viewId);
line number: 54 from tag: refs/tags/3.1.0-RC1 commit: 4dec8dc6b22c3fb536b3c906a0edc30b42f0005f

------------------

$ line=79; pattern=Restor; file=bridge-impl/src/main/java/com/liferay/faces/bridge/application/ViewHandlerImpl.java; echo; git show-ref --tags | while read ct; do c=`echo $ct | cut -f1 -d" "`; t=`echo $ct | cut -f2 -d" "`; git show $c:$file | head -${line} | tail -1 | grep $pattern && echo "line number: $line from tag: $t commit: $c"; done

logger.debug("Restoring view for viewId=[{0}]", viewId);
line number: 79 from tag: refs/tags/3.0.0-BETA1 commit: 7da8c59658e75b43e4c9cde62a82846483c9e3fa
logger.debug("Restoring view for viewId=[{0}]", viewId);
line number: 79 from tag: refs/tags/3.0.0-BETA2 commit: 496134617fbc141e7ccc027bd071ab1d11e57f19
logger.debug("Restoring view for viewId=[{0}]", viewId);
line number: 79 from tag: refs/tags/3.0.0-RC1 commit: 529e98cebe00a244256265bd72902844c46b3a00
logger.debug("Restoring view for viewId=[{0}]", viewId);
line number: 79 from tag: refs/tags/3.1.0-BETA1 commit: 16bf8ef60a407bba2df89fa036d6e132eaf19825
logger.debug("Restoring view for viewId=[{0}]", viewId);
line number: 79 from tag: refs/tags/3.1.0-BETA2 commit: 14770509cbca6ca0c73256bc4d31fe29893d2ed2
logger.debug("Restoring view for viewId=[{0}]", viewId);
line number: 79 from tag: refs/tags/3.1.0-RC1 commit: 4dec8dc6b22c3fb536b3c906a0edc30b42f0005f

Looks to me like these must be from Release Candidate or Beta versions.
Would it be possible for you to upgrade to a supported version of the Liferay Faces Bridge?

You should be able to download that from here:
http://www.liferay.com/community/liferay-projects/liferay-faces/download

Hope that helps,
Vernon Singleton