2 Replies Latest reply on Dec 4, 2008 10:44 AM by Chris NameToUpdate

    PXE Service fails to start on boot

      My PXE server is on a 2k3 VM. When I boot the system, all of my BL specific services will start automatically except for my PXE server. However, if I open my services page and manually start the PXE server, it will come up and operate without a problem.

       

      I've clipped the portion of my log file that demonstrates this behavior. In the log, you'll see PXE try to start twice. The first time, it fails when connecting to the database. The second time, everything goes as advertised.

       

      This obviously points to a problem accessing the database on boot. Unfortunately, I'm at a loss as to how to fix that. Ideas?

       


      [03 Dec 2008 17:37:53,437] [main] [INFO] Starting Sizing service...
      [03 Dec 2008 17:37:53,671] [main] [INFO] Sizing service started
      [03 Dec 2008 17:37:53,671] [main] [INFO] Starting Caching service...
      [03 Dec 2008 17:37:53,687] [main] [INFO] Caching service started
      [03 Dec 2008 17:37:53,687] [main] [INFO] Starting Session service...
      [03 Dec 2008 17:37:53,687] [main] [INFO] Session service started
      [03 Dec 2008 17:37:54,546] [main] [INFO] Starting Configuration service...
      [03 Dec 2008 17:37:54,890] [main] [INFO] Configuration service started
      [03 Dec 2008 17:37:54,890] [main] [INFO] Starting Model service...
      [03 Dec 2008 17:37:58,203] [main] [INFO] Loading SQL queries file: sqlmap.properties
      [03 Dec 2008 17:37:58,546] [main] [INFO] Loading SQL queries file: streamable_sqlmap.properties
      [03 Dec 2008 17:37:58,578] [main] [INFO] Model service started
      [03 Dec 2008 17:37:58,578] [main] [INFO] Starting Database service...
      [03 Dec 2008 17:38:00,109] [main] [INFO] Failed to initialize connection poolConnection info :
      dbName=DEFAULT, driver=com.microsoft.sqlserver.jdbc.SQLServerDriver, url=jdbc:sqlserver://win1:1433;DatabaseName=bladelogic;SelectMethod=cursor
      user=bladelogic
      com.bladelogic.mfw.util.BlException: java.sql.SQLException: The TCP/IP connection to the host has failed. java.net.ConnectException: Connection refused: connect
      at com.bladelogic.mfw.db.dbcp.BlDbDbcpConnPool.<init>(BlDbDbcpConnPool.java:93)
      at com.bladelogic.mfw.db.BlDbConnPoolFactory.createConnectionPool(BlDbConnPoolFactory.java:10)
      at com.bladelogic.mfw.db.BlDbConnManager.setConn(BlDbConnManager.java:209)
      at com.bladelogic.app.service.db.DatabaseServiceImpl.initDepots(DatabaseServiceImpl.java:226)
      at com.bladelogic.app.service.db.DatabaseServiceImpl.initAllDepots(DatabaseServiceImpl.java:126)
      at com.bladelogic.app.service.db.DatabaseServiceImpl.start(DatabaseServiceImpl.java:93)
      at com.bladelogic.app.service.ServiceHandler.startService(ServiceHandler.java:96)
      at com.bladelogic.app.service.ServiceManager.startService(ServiceManager.java:424)
      at com.bladelogic.app.service.ServiceManager.startDatabaseService(ServiceManager.java:816)
      at com.bladelogic.pxe.PxeMain.<init>(PxeMain.java:60)
      at com.bladelogic.pxe.PxeWindowsService.start(PxeWindowsService.java:23)
      at com.bladelogic.app.WindowsServiceRunner.startService(WindowsServiceRunner.java:79)
      Caused by: java.sql.SQLException: The TCP/IP connection to the host has failed. java.net.ConnectException: Connection refused: connect
      at com.bladelogic.mfw.db.dbcp.BlDbConnectionFactory.createConnection(BlDbConnectionFactory.java:65)
      at org.apache.commons.dbcp.PoolableConnectionFactory.makeObject(PoolableConnectionFactory.java:294)
      at org.apache.commons.pool.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:840)
      at com.bladelogic.mfw.db.BlDbConnObjectPool.borrowObject(BlDbConnObjectPool.java:60)
      at org.apache.commons.dbcp.PoolingDataSource.getConnection(PoolingDataSource.java:96)
      at com.bladelogic.mfw.db.dbcp.BlDbDbcpConnPool.<init>(BlDbDbcpConnPool.java:84)
      ... 11 more
      [03 Dec 2008 17:38:00,109] [main] [ERROR] PxeMain: Failed to start database service
      com.bladelogic.app.service.ServiceInitializationException: Failed to start database service
      at com.bladelogic.app.service.db.DatabaseServiceImpl.start(DatabaseServiceImpl.java:105)
      at com.bladelogic.app.service.ServiceHandler.startService(ServiceHandler.java:96)
      at com.bladelogic.app.service.ServiceManager.startService(ServiceManager.java:424)
      at com.bladelogic.app.service.ServiceManager.startDatabaseService(ServiceManager.java:816)
      at com.bladelogic.pxe.PxeMain.<init>(PxeMain.java:60)
      at com.bladelogic.pxe.PxeWindowsService.start(PxeWindowsService.java:23)
      at com.bladelogic.app.WindowsServiceRunner.startService(WindowsServiceRunner.java:79)
      Caused by: com.bladelogic.app.db.DBException: Failed to initialize connection poolConnection info :
      dbName=DEFAULT, driver=com.microsoft.sqlserver.jdbc.SQLServerDriver, url=jdbc:sqlserver://win1:1433;DatabaseName=bladelogic;SelectMethod=cursor
      user=bladelogic
      at com.bladelogic.mfw.db.BlDbConnManager.setConn(BlDbConnManager.java:224)
      at com.bladelogic.app.service.db.DatabaseServiceImpl.initDepots(DatabaseServiceImpl.java:226)
      at com.bladelogic.app.service.db.DatabaseServiceImpl.initAllDepots(DatabaseServiceImpl.java:126)
      at com.bladelogic.app.service.db.DatabaseServiceImpl.start(DatabaseServiceImpl.java:93)
      ... 6 more
      Caused by: com.bladelogic.mfw.util.BlException: java.sql.SQLException: The TCP/IP connection to the host has failed. java.net.ConnectException: Connection refused: connect
      at com.bladelogic.mfw.db.dbcp.BlDbDbcpConnPool.<init>(BlDbDbcpConnPool.java:93)
      at com.bladelogic.mfw.db.BlDbConnPoolFactory.createConnectionPool(BlDbConnPoolFactory.java:10)
      at com.bladelogic.mfw.db.BlDbConnManager.setConn(BlDbConnManager.java:209)
      ... 9 more
      Caused by: java.sql.SQLException: The TCP/IP connection to the host has failed. java.net.ConnectException: Connection refused: connect
      at com.bladelogic.mfw.db.dbcp.BlDbConnectionFactory.createConnection(BlDbConnectionFactory.java:65)
      at org.apache.commons.dbcp.PoolableConnectionFactory.makeObject(PoolableConnectionFactory.java:294)
      at org.apache.commons.pool.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:840)
      at com.bladelogic.mfw.db.BlDbConnObjectPool.borrowObject(BlDbConnObjectPool.java:60)
      at org.apache.commons.dbcp.PoolingDataSource.getConnection(PoolingDataSource.java:96)
      at com.bladelogic.mfw.db.dbcp.BlDbDbcpConnPool.<init>(BlDbDbcpConnPool.java:84)
      ... 11 more
      [03 Dec 2008 17:39:11,843] [main] [INFO] Starting Sizing service...
      [03 Dec 2008 17:39:11,843] [main] [INFO] Sizing service started
      [03 Dec 2008 17:39:11,843] [main] [INFO] Starting Caching service...
      [03 Dec 2008 17:39:11,859] [main] [INFO] Caching service started
      [03 Dec 2008 17:39:11,859] [main] [INFO] Starting Session service...
      [03 Dec 2008 17:39:11,859] [main] [INFO] Session service started
      [03 Dec 2008 17:39:11,906] [main] [INFO] Starting Configuration service...
      [03 Dec 2008 17:39:12,062] [main] [INFO] Configuration service started
      [03 Dec 2008 17:39:12,078] [main] [INFO] Starting Model service...
      [03 Dec 2008 17:39:13,796] [main] [INFO] Loading SQL queries file: sqlmap.properties
      [03 Dec 2008 17:39:13,843] [main] [INFO] Loading SQL queries file: streamable_sqlmap.properties
      [03 Dec 2008 17:39:13,875] [main] [INFO] Model service started
      [03 Dec 2008 17:39:13,875] [main] [INFO] Starting Database service...
      [03 Dec 2008 17:39:14,500] [main] [INFO] Database service started
      [03 Dec 2008 17:39:14,625] [main] [INFO] Will bind to eth0
      [03 Dec 2008 17:39:14,640] [main] [INFO] Will bind to Mcast interfaces
      [03 Dec 2008 17:39:14,656] [main] [INFO] PxeMain : Starting PXE Server Single DB Mode connecting to DEFAULT Database
      [03 Dec 2008 17:39:14,734] [Thread-3] [INFO] (U)FD:1908
      [03 Dec 2008 17:39:14,734] [Thread-3] [INFO] (U)FD:1920
      [03 Dec 2008 17:39:14,734] [Thread-3] [INFO] (M)FD:1928
      [03 Dec 2008 17:39:14,734] [Thread-3] [INFO] (M)FD:1936