0005893: init(final ServletConfig config) seems to be called more than once.

Viewing Issue Simple Details [ Jump to Notes ]

[ View Advanced ] [ Issue History ] [ Print ]

Category

Severity

Reproducibility

Date Submitted

Last Update

0005893

[Resin]

major

random

05-06-15 07:56

06-10-15 09:34

Reporter

Mathias Lagerwall

View Status

public

Assigned To

ferg

Priority

normal

Resolution

fixed

Status

closed

Product Version

4.0.44

Summary

0005893: init(final ServletConfig config) seems to be called more than once.

Description

Resin version 4.0.s150407 (4.0.43 + some of the .44 fixes)

We got this version from you to get rid of the problem with the session databases size problem (0005865). And it looks like it is solved. However we now see another nasty problem.

When we restart the application we sometimes get a double startup.
We bring our application up via the init(ServletConfig config) method. This has not been a problem before but with this Resin version we see two instances of the application starting.

We use the <load-on-startup> so the init-method is called directly at startup. We have Apache servers in-front of the servers and we use clustering if that can give any hints of what the problem is.

Below is a sample of one of the startups. Please note the {resin-80} and {resin-79}. There should only be one of them.

[15-04-29 17:43:01.501] {main} XXXXXXXX.license -- 16 Resin servers XXXXXXXXXXXXX

[15-04-29 17:43:02.091] {main} Proxy Cache disk-size=1024M memory-size=128M
[15-04-29 17:43:02.505] {main}
[15-04-29 17:43:02.505] {main} Resin Professional 4.0.s150407 (built Tue, 07 Apr 2015 12:29:14 PDT)
[15-04-29 17:43:02.506] {main}
[15-04-29 17:43:02.506] {main} Windows Server 2008 R2 6.1 amd64
[15-04-29 17:43:02.506] {main} Java(TM) SE Runtime Environment 1.8.0_45-b14, Cp1252, en
[15-04-29 17:43:02.507] {main} Java HotSpot(TM) 64-Bit Server VM 25.45-b02, 64, mixed mode, Oracle Corporation
[15-04-29 17:43:02.507] {main}
[15-04-29 17:43:02.507] {main} user.name = SESHCAUDKHOS006$
[15-04-29 17:43:02.985] {main} Table[stat_name:3,d:\resin-pro-4.0.s150407\resin-data\se_c_c\stat_name.db] validating indexes due to unclean shutdown.
[15-04-29 17:43:03.045] {main} Table[stat_data:4,d:\resin-pro-4.0.s150407\resin-data\se_c_c\stat_data.db] validating indexes due to unclean shutdown.
[15-04-29 17:43:05.258] {main}
[15-04-29 17:43:05.265] {main} server listening to SESHCAUDKHOS006.eshop.local:6809
[15-04-29 17:43:05.271] {main}
[15-04-29 17:43:06.638] {main}
[15-04-29 17:43:06.639] {main} resin.home = d:\resin-pro-4.0.s150407
[15-04-29 17:43:06.639] {main} resin.root = d:\resin-pro-4.0.s150407
[15-04-29 17:43:06.639] {main} resin.conf = d:\etailerse_common\conf\resin_se.xml
[15-04-29 17:43:06.639] {main}
[15-04-29 17:43:06.639] {main} server = 10.200.20.75:6809 (app-tier:se_c_c)
[15-04-29 17:43:06.639] {main} stage = production
[15-04-29 17:43:06.666] {resin-port-10.200.20.75:6809-61} Host[production/host/default] stopping
[15-04-29 17:43:12.854] {resin-port-10.200.20.75:6809-27} In-place class redefinition (HotSwap) is available.
[15-04-29 17:43:13.550] {resin-80} WebApp[production/webapp/default/senew,STARTING] Initializing Spring root WebApplicationContext
[15-04-29 17:43:13.551] {resin-79} WebApp[production/webapp/default/senew,STARTING] Initializing Spring root WebApplicationContext
[15-04-29 17:43:17.078] {resin-80} Creating Service {http:// XXXXXXXX /}PriceCatalogService from class se.netset.etailer.io.ws.pricecatalog.PriceCatalogService
[15-04-29 17:43:17.111] {resin-79} Creating Service {http:// XXXXXXXX /}PriceCatalogService from class se.netset.etailer.io.ws.pricecatalog.PriceCatalogService
[15-04-29 17:43:18.460] {resin-79} Setting the server's publish address to be /PriceCatalogService
[15-04-29 17:43:18.544] {resin-80} Setting the server's publish address to be /PriceCatalogService
2015-04-29 17:43:18 eshopse3.atea.com [/senew/]: Booting.
2015-04-29 17:43:18 eshopse3.atea.com: Application root is 'd:\etailerse_common\deploy\ROOT'.
2015-04-29 17:43:18 eshopse3.atea.com: Using configuration [file: XXXXXXXX].
2015-04-29 17:43:18 eshopse3.atea.com: Building using 'se.netset.etailer.AppBuilder'
2015-04-29 17:43:18 eshopse3.atea.com [/senew/]: Booting.
2015-04-29 17:43:18 eshopse3.atea.com: Application root is 'd:\etailerse_common\deploy\ROOT'.
2015-04-29 17:43:18 eshopse3.atea.com: Using configuration [file: XXXXXXXX].
2015-04-29 17:43:18 eshopse3.atea.com: Building using 'se.netset.etailer.AppBuilder'
[2015-04-29 17:43:21] Verifying connection to [jdbc:sqlserver://10.200.20.63;database=etailerse_common;failoverPartner=10.200.20.64;responseBuffering=adaptive] [^]
[2015-04-29 17:43:21] Verifying connection to [jdbc:sqlserver://10.200.20.63;database=etailerse_common;failoverPartner=10.200.20.64;responseBuffering=adaptive] [^]
.........
.........

Additional Information

Attached Files

Relationships

There are no notes attached to this issue.

Issue History
Date Modified	Username	Field	Change
05-06-15 07:56	Mathias Lagerwall	New Issue
05-06-15 07:58	Mathias Lagerwall	Issue Monitored: Mathias Lagerwall
06-10-15 09:34	ferg	Assigned To	=> ferg
06-10-15 09:34	ferg	Status	new => closed
06-10-15 09:34	ferg	Resolution	open => fixed
06-10-15 09:34	ferg	Fixed in Version	=> 4.0.45

Mantis 1.0.0rc3[^]

28 total queries executed.
25 unique queries executed.