com.enioka.jqm.tools.JqmEngine Maven / Gradle / Ivy
Go to download
Show more of this group Show more artifacts with this name
Show all versions of jqm-engine Show documentation
Show all versions of jqm-engine Show documentation
A library containing the JQM engine. Cannot be used alone.
/**
* Copyright © 2013 enioka. All rights reserved
* Authors: Marc-Antoine GOUILLART ([email protected])
* Pierre COPPEE ([email protected])
*
* Licensed under the Apache License, Version 2.0 (the "License");
* you may not use this file except in compliance with the License.
* You may obtain a copy of the License at
*
* http://www.apache.org/licenses/LICENSE-2.0
*
* Unless required by applicable law or agreed to in writing, software
* distributed under the License is distributed on an "AS IS" BASIS,
* WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
* See the License for the specific language governing permissions and
* limitations under the License.
*/
package com.enioka.jqm.tools;
import java.io.OutputStreamWriter;
import java.lang.management.ManagementFactory;
import java.util.Calendar;
import java.util.HashMap;
import java.util.List;
import java.util.Map;
import java.util.Queue;
import java.util.concurrent.Semaphore;
import java.util.concurrent.atomic.AtomicLong;
import javax.management.MBeanServer;
import javax.management.ObjectName;
import javax.persistence.EntityManager;
import javax.persistence.LockModeType;
import org.apache.commons.io.FilenameUtils;
import org.apache.log4j.ConsoleAppender;
import org.apache.log4j.Logger;
import org.apache.log4j.RollingFileAppender;
import org.eclipse.jetty.util.ArrayQueue;
import com.enioka.jqm.jpamodel.DeploymentParameter;
import com.enioka.jqm.jpamodel.GlobalParameter;
import com.enioka.jqm.jpamodel.History;
import com.enioka.jqm.jpamodel.JobInstance;
import com.enioka.jqm.jpamodel.Message;
import com.enioka.jqm.jpamodel.Node;
import com.enioka.jqm.jpamodel.State;
/**
* The engine itself. Everything starts in this class.
*/
class JqmEngine implements JqmEngineMBean, JqmEngineOperations
{
private static Logger jqmlogger = Logger.getLogger(JqmEngine.class);
static String latestNodeStartedName = "";
// Sync data for stopping the engine
private Semaphore ended = new Semaphore(0);
private boolean hasEnded = false;
// Parameters and parameter cache
private Node node = null;
private ObjectName name;
private final ClassloaderManager clManager = new ClassloaderManager();
// Threads that together constitute the engine
private Map pollers = new HashMap();
private InternalPoller intPoller = null;
private JettyServer server = null;
// Misc data
private Calendar startTime = Calendar.getInstance();
private Thread killHook = null;
boolean loadJmxBeans = true;
private AtomicLong endedInstances = new AtomicLong(0);
// DB connection resilience data
private volatile Queue qpToRestart = new ArrayQueue();
private volatile Queue loaderToFinalize = new ArrayQueue();
private volatile Queue loaderToRestart = new ArrayQueue();
private volatile Thread qpRestarter = null;
/**
* Starts the engine
*
* @param nodeName
* the name of the node to start, as in the NODE table of the database.
* @throws JqmInitError
*/
void start(String nodeName)
{
if (nodeName == null || nodeName.isEmpty())
{
throw new IllegalArgumentException("nodeName cannot be null or empty");
}
// Set thread name - used in audits
Thread.currentThread().setName("JQM engine;;" + nodeName);
Helpers.setLogFileName(nodeName);
// Log: we are starting...
jqmlogger.info("JQM engine version " + this.getVersion() + " for node " + nodeName + " is starting");
jqmlogger.info("Java version is " + System.getProperty("java.version") + ". JVM was made by " + System.getProperty("java.vendor")
+ " as " + System.getProperty("java.vm.name") + " version " + System.getProperty("java.vm.version"));
// JNDI first - the engine itself uses JNDI to fetch its connections!
Helpers.registerJndiIfNeeded();
// Database connection
EntityManager em = Helpers.getNewEm();
// Node configuration is in the database
node = em.createQuery("SELECT n FROM Node n WHERE n.name = :l", Node.class).setParameter("l", nodeName).getSingleResult();
// Check if double-start
long toWait = (long) (1.1 * Long.parseLong(Helpers.getParameter("internalPollingPeriodMs", "60000", em)));
if (node.getLastSeenAlive() != null
&& Calendar.getInstance().getTimeInMillis() - node.getLastSeenAlive().getTimeInMillis() <= toWait)
{
long r = Calendar.getInstance().getTimeInMillis() - node.getLastSeenAlive().getTimeInMillis();
throw new JqmInitErrorTooSoon("Another engine named " + nodeName + " was running less than " + r / 1000
+ " seconds ago. Either stop the other node, or if it already stopped, please wait " + (toWait - r) / 1000
+ " seconds");
}
// Prevent very quick multiple starts by immediately setting the keep-alive
em.getTransaction().begin();
node.setLastSeenAlive(Calendar.getInstance());
em.getTransaction().commit();
// Only start if the node configuration seems OK
Helpers.checkConfiguration(nodeName, em);
// Log parameters
Helpers.dumpParameters(em, node);
// Log level
Helpers.setLogLevel(node.getRootLogLevel());
// Log multicasting (& log4j stdout redirect)
GlobalParameter gp1 = em.createQuery("SELECT g FROM GlobalParameter g WHERE g.key = :k", GlobalParameter.class)
.setParameter("k", "logFilePerLaunch").getSingleResult();
if ("true".equals(gp1.getValue()) || "both".equals(gp1.getValue()))
{
RollingFileAppender a = (RollingFileAppender) Logger.getRootLogger().getAppender("rollingfile");
MultiplexPrintStream s = new MultiplexPrintStream(System.out, FilenameUtils.getFullPath(a.getFile()),
"both".equals(gp1.getValue()));
System.setOut(s);
((ConsoleAppender) Logger.getRootLogger().getAppender("consoleAppender")).setWriter(new OutputStreamWriter(s));
s = new MultiplexPrintStream(System.err, FilenameUtils.getFullPath(a.getFile()), "both".equals(gp1.getValue()));
System.setErr(s);
}
// Remote JMX server
if (node.getJmxRegistryPort() != null && node.getJmxServerPort() != null && node.getJmxRegistryPort() > 0
&& node.getJmxServerPort() > 0)
{
JmxAgent.registerAgent(node.getJmxRegistryPort(), node.getJmxServerPort(), node.getDns());
}
else
{
jqmlogger.info(
"JMX remote listener will not be started as JMX registry port and JMX server port parameters are not both defined");
}
// Jetty
this.server = new JettyServer();
this.server.start(node, em);
// JMX
if (node.getJmxServerPort() != null && node.getJmxServerPort() > 0)
{
try
{
MBeanServer mbs = ManagementFactory.getPlatformMBeanServer();
name = new ObjectName("com.enioka.jqm:type=Node,name=" + this.node.getName());
mbs.registerMBean(this, name);
}
catch (Exception e)
{
throw new JqmInitError("Could not create JMX beans", e);
}
jqmlogger.info("JMX management bean for the engine was registered");
}
else
{
loadJmxBeans = false;
jqmlogger.info("JMX management beans will not be loaded as JMX server port is null or zero");
}
// Security
if (System.getSecurityManager() == null)
{
System.setSecurityManager(new SecurityManagerPayload());
}
jqmlogger.info("Security manager was registered");
// Cleanup
purgeDeadJobInstances(em, this.node);
// Force Message EMF load
em.createQuery("SELECT m FROM Message m WHERE 1=0", Message.class).getResultList();
// Pollers
syncPollers(em, this.node);
jqmlogger.info("All required queues are now polled");
// Internal poller (stop notifications, keepalive)
intPoller = new InternalPoller(this);
Thread t = new Thread(intPoller);
t.start();
// Kill notifications
killHook = new SignalHandler(this);
Runtime.getRuntime().addShutdownHook(killHook);
// Done
em.close();
em = null;
latestNodeStartedName = node.getName();
jqmlogger.info("End of JQM engine initialization");
}
/**
* Gracefully stop the engine
*/
@Override
public void stop()
{
synchronized (killHook)
{
jqmlogger.info("JQM engine " + this.node.getName() + " has received a stop order");
// Kill hook should be removed
try
{
if (!Runtime.getRuntime().removeShutdownHook(killHook))
{
jqmlogger.error("The engine could not unregister its shutdown hook");
}
}
catch (IllegalStateException e)
{
// This happens if the stop sequence is initiated by the shutdown hook itself.
jqmlogger.info("Stop order is due to an admin operation (KILL/INT)");
}
}
// Stop pollers
for (QueuePoller p : pollers.values())
{
p.stop();
}
// Jetty is closed automatically when all pollers are down
// Wait for the end of the world
try
{
this.ended.acquire();
}
catch (InterruptedException e)
{
jqmlogger.error("interrupted", e);
}
jqmlogger.debug("Stop order was correctly handled. Engine for node " + this.node.getName() + " has stopped.");
}
Node getNode()
{
return this.node;
}
synchronized void syncPollers(EntityManager em, Node node)
{
if (node.getEnabled())
{
List dps = em
.createQuery("SELECT dp FROM DeploymentParameter dp WHERE dp.node.id = :n", DeploymentParameter.class)
.setParameter("n", node.getId()).getResultList();
QueuePoller p = null;
for (DeploymentParameter i : dps)
{
if (pollers.containsKey(i.getId()))
{
p = pollers.get(i.getId());
p.setPollingInterval(i.getPollingInterval());
if (i.getEnabled())
{
p.setMaxThreads(i.getNbThread());
}
else
{
p.setMaxThreads(0);
}
}
else
{
p = new QueuePoller(this, i.getQueue(), (i.getEnabled() ? i.getNbThread() : 0), i.getPollingInterval());
pollers.put(i.getId(), p);
Thread t = new Thread(p);
t.start();
}
}
// Remove deleted pollers
for (int dp : this.pollers.keySet().toArray(new Integer[0]))
{
boolean found = false;
for (DeploymentParameter ndp : dps)
{
if (ndp.getId().equals(dp))
{
found = true;
break;
}
}
if (!found)
{
QueuePoller qp = this.pollers.get(dp);
qp.stop();
this.pollers.remove(dp);
}
}
}
else
{
// Pause all pollers
for (QueuePoller qp : this.pollers.values())
{
qp.setMaxThreads(0);
}
}
}
synchronized void checkEngineEnd()
{
jqmlogger.trace("Checking if engine should end with the latest poller");
for (QueuePoller poller : pollers.values())
{
if (poller.isRunning())
{
jqmlogger.trace("At least the poller on queue " + poller.getQueue().getName() + " is still running and prevents shutdown");
return;
}
}
if (hasEnded)
{
return;
}
jqmlogger.trace("The engine should end with the latest poller");
hasEnded = true;
// If here, all pollers are down. Stop Jetty too
this.server.stop();
// Also stop the internal poller
this.intPoller.stop();
// Reset the stop counter - we may want to restart one day
EntityManager em = null;
try
{
em = Helpers.getNewEm();
em.getTransaction().begin();
this.node = em.find(Node.class, this.node.getId(), LockModeType.PESSIMISTIC_WRITE);
this.node.setStop(false);
this.node.setLastSeenAlive(null);
em.getTransaction().commit();
}
catch (Exception e)
{
// Shutdown exception is ignored (happens during tests)
}
finally
{
Helpers.closeQuietly(em);
}
// JMX
if (loadJmxBeans)
{
try
{
MBeanServer mbs = ManagementFactory.getPlatformMBeanServer();
mbs.unregisterMBean(name);
jqmlogger.trace("unregistered bean " + name);
}
catch (Exception e)
{
jqmlogger.error("Could not unregister engine JMX bean", e);
}
}
// Note: if present, the JMX listener is not stopped as it is JVM-global, like the JNDI context
// Done
this.ended.release();
jqmlogger.info("JQM engine has stopped");
}
private void purgeDeadJobInstances(EntityManager em, Node node)
{
em.getTransaction().begin();
for (JobInstance ji : em.createQuery("SELECT ji FROM JobInstance ji WHERE ji.node = :node", JobInstance.class)
.setParameter("node", node).getResultList())
{
History h = em.find(History.class, ji.getId());
if (h == null)
{
h = Helpers.createHistory(ji, em, State.CRASHED, Calendar.getInstance());
Message m = new Message();
m.setJi(ji.getId());
m.setTextMessage(
"Job was supposed to be running at server startup - usually means it was killed along a server by an admin or a crash");
em.persist(m);
}
em.createQuery("DELETE FROM JobInstance WHERE id = :i").setParameter("i", ji.getId()).executeUpdate();
}
em.getTransaction().commit();
}
/**
* A poller should call this method when it encounters a database connection issue, and then should stop.
* This will ensure the poller is restarted when database connectivity is restored.
* Only pollers which have called this method are restarted, other are deemed not to have crashed.
*/
void pollerRestartNeeded(QueuePoller qp)
{
qpToRestart.add(qp);
startDbRestarter();
}
void loaderFinalizationNeeded(Loader l)
{
loaderToFinalize.add(l);
startDbRestarter();
}
void loaderRestartNeeded(Loader l)
{
loaderToRestart.add(l);
startDbRestarter();
}
void startDbRestarter()
{
// On first alert, start the thread which will check connection restoration and relaunch the pollers.
synchronized (this)
{
if (qpRestarter != null)
{
return;
}
}
final JqmEngine ee = this;
qpRestarter = new Thread()
{
@Override
public void run()
{
// Test if the DB is back and wait for it if not
jqmlogger.warn("The engine will now indefinitely try to restore connection to the database");
EntityManager em = null;
boolean back = false;
long timeToWait = 1;
while (!back)
{
try
{
synchronized (ee)
{
em = Helpers.getNewEm();
em.find(Node.class, 1);
back = true;
ee.qpRestarter = null;
jqmlogger.warn("connection to database was restored");
}
}
catch (Exception e)
{
// The db is not back yet
try
{
jqmlogger.debug("waiting for db...");
Thread.sleep(1000 * timeToWait);
timeToWait = Math.min(timeToWait + 1, 120);
}
catch (InterruptedException e1)
{
// Not an issue here.
jqmlogger.debug("interrupted wait in db restarter");
}
}
finally
{
Helpers.closeQuietly(em);
}
}
// Restart pollers
QueuePoller qp = qpToRestart.poll();
while (qp != null)
{
jqmlogger.warn("resetting poller on queue " + qp.getQueue().getName());
qp.reset();
Thread t = new Thread(qp);
t.start();
qp = qpToRestart.poll();
}
// Always restart internal poller
intPoller.stop();
ee.intPoller = new InternalPoller(ee);
Thread t = new Thread(ee.intPoller);
t.start();
// Finalize loaders that could not store their result inside the database
Loader l = loaderToFinalize.poll();
while (l != null)
{
jqmlogger.warn("storing delayed results for loader " + l.getId());
l.endOfRunDb();
l = loaderToFinalize.poll();
}
// Restart loaders that have failed during initialization
l = loaderToRestart.poll();
while (l != null)
{
jqmlogger.warn("restarting (after db failure during initialization) loader " + l.getId());
(new Thread(l)).start();
l = loaderToRestart.poll();
}
// Done - let the thread end.
}
};
qpRestarter.start();
}
ClassloaderManager getClassloaderManager()
{
return this.clManager;
}
JettyServer getJetty()
{
return this.server;
}
void signalEndOfRun()
{
this.endedInstances.incrementAndGet();
}
// //////////////////////////////////////////////////////////////////////////
// JMX stat methods (they get their own EM to be thread safe)
// //////////////////////////////////////////////////////////////////////////
@Override
public long getCumulativeJobInstancesCount()
{
return this.endedInstances.get();
}
@Override
public long getCurrentlyRunningJobCount()
{
Long nb = 0L;
for (QueuePoller p : this.pollers.values())
{
nb += p.getCurrentlyRunningJobCount();
}
return nb;
}
@Override
public boolean isAllPollersPolling()
{
for (QueuePoller p : this.pollers.values())
{
if (!p.isActuallyPolling())
{
return false;
}
}
return true;
}
@Override
public boolean isFull()
{
for (QueuePoller p : this.pollers.values())
{
if (p.isFull())
{
return true;
}
}
return false;
}
@Override
public int getLateJobs()
{
int res = 0;
for (QueuePoller p : this.pollers.values())
{
res += p.getLateJobs();
}
return res;
}
@Override
public long getUptime()
{
return (Calendar.getInstance().getTimeInMillis() - this.startTime.getTimeInMillis()) / 1000;
}
@Override
public String getVersion()
{
return Helpers.getMavenVersion();
}
@Override
public void pause()
{
EntityManager em = Helpers.getNewEm();
em.getTransaction().begin();
em.createQuery("UPDATE Node n SET n.enabled = false WHERE n.id = :id").setParameter("id", node.getId()).executeUpdate();
em.getTransaction().commit();
em.close();
refreshConfiguration();
}
@Override
public void resume()
{
EntityManager em = Helpers.getNewEm();
em.getTransaction().begin();
em.createQuery("UPDATE Node n SET n.enabled = true WHERE n.id = :id").setParameter("id", node.getId()).executeUpdate();
em.getTransaction().commit();
em.close();
refreshConfiguration();
}
@Override
public void refreshConfiguration()
{
this.intPoller.forceLoop();
}
}