Author Topic: Flexraid System/Process Status  (Read 3876 times)

Offline morbandit

  • Newbie
  • *
  • Posts: 31
  • Karma: +0/-0
    • View Profile
Flexraid System/Process Status
« on: May 01, 2013, 06:22:15 pm »
Hey

Wondering how I tell what Flexraid is up to? In Task Manager (Win Server 2012) Flexraid is using almost 4gb of RAM and 12 - 17% CPU. How do I tell whether it's doing something useful like Updating or Verifying, or whether it's just a memory leak of some sort?

Thanks in advance

Offline Xander260

  • Newbie
  • *
  • Posts: 23
  • Karma: +1/-0
    • View Profile
Re: Flexraid System/Process Status
« Reply #1 on: June 25, 2013, 02:03:55 am »
If you log onto the web interface, the first thing that should show up after login/loading is a progress window showing the current progress of a verification/update/etc if any is running. If you dont see anything show automatically, it should be idle.

Do you see this?

Offline morbandit

  • Newbie
  • *
  • Posts: 31
  • Karma: +0/-0
    • View Profile
Re: Flexraid System/Process Status
« Reply #2 on: October 07, 2013, 12:36:50 am »
Don't see anything in the web interface. It's currently using 12.5% CPU and ~100MB of memory after a reboot. My storage pool is currently inaccessible.

Checking the logs say the following:

Quote
[2013-10-07 17:46:46,619] INFO : Setting core service port to 9595
[2013-10-07 17:46:46,635] INFO : Setting Http port to 8080
[2013-10-07 17:46:46,635] INFO : Https port not set. Https requests will not be serviced...
[2013-10-07 17:46:46,963] INFO : Starting FlexRAID...
[2013-10-07 17:46:46,963] INFO : FlexRAID 2.0u11 final [Snapshot 1.4 stable / Storage Pool 1.0 RC / Real-Time 1.0 experimental]
[2013-10-07 17:46:46,963] INFO : Started: 7 October 2013 5:46:46 PM
[2013-10-07 17:46:48,470] INFO : Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
[2013-10-07 17:46:48,470] INFO : Quartz Scheduler v.1.8.4 created.
[2013-10-07 17:46:48,470] INFO : Registering Quartz shutdown hook.
[2013-10-07 17:46:48,470] INFO : Using thread monitor-based data access locking (synchronization).
[2013-10-07 17:46:49,502] INFO : Removed 0 Volatile Trigger(s).
[2013-10-07 17:46:49,502] INFO : Removed 0 Volatile Job(s).
[2013-10-07 17:46:49,564] INFO : JobStoreTX initialized.
[2013-10-07 17:46:49,564] INFO : Scheduler meta-data: Quartz Scheduler (v1.8.4) 'flexraid' with instanceId '1'
  Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
  NOT STARTED.
  Currently in standby mode.
  Number of jobs executed: 0
  Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 3 threads.
  Using job-store 'org.quartz.impl.jdbcjobstore.JobStoreTX' - which supports persistence. and is not clustered.

[2013-10-07 17:46:49,564] INFO : Quartz scheduler 'flexraid' initialized from default resource file in Quartz package: 'quartz.properties'
[2013-10-07 17:46:49,564] INFO : Quartz scheduler version: 1.8.4
[2013-10-07 17:46:51,144] INFO : Freed 0 triggers from 'acquired' / 'blocked' state.
[2013-10-07 17:46:51,207] INFO : Handling the first 0 triggers that missed their scheduled fire-time.  More misfired triggers remain to be processed.
[2013-10-07 17:46:51,207] INFO : Recovering 0 jobs that were in-progress at the time of the last shut-down.
[2013-10-07 17:46:51,207] INFO : Recovery complete.
[2013-10-07 17:46:51,207] INFO : Removed 0 'complete' triggers.
[2013-10-07 17:46:51,910] INFO : Removed 1 stale fired job entries.
[2013-10-07 17:46:51,910] INFO : Scheduler flexraid_$_1 started.
[2013-10-07 17:46:51,910] INFO : Handling the first 1 triggers that missed their scheduled fire-time.  More misfired triggers remain to be processed.
[2013-10-07 17:46:52,019] INFO : jetty-7.x.y-SNAPSHOT
[2013-10-07 17:46:52,144] INFO : Trigger validate.HD Movies[validate][Every MON at: 04:30:00
[Starting = null/null/null null:null:null]
[Ending = null/null/null null:null:null]] misfired job HD Movies.HD Movies[validate]  at:  17:46:52 10/07/2013.  Should have fired at:  04:30:00 10/07/2013
[2013-10-07 17:46:52,316] INFO : started o.e.j.s.ServletContextHandler{/,null}
[2013-10-07 17:46:53,796] INFO : Trigger validate.HD Movies[validate][Every MON at: 04:30:00
[Starting = null/null/null null:null:null]
[Ending = null/null/null null:null:null]] fired job HD Movies.HD Movies[validate] at:  17:46:53 10/07/2013
[2013-10-07 17:46:55,268] INFO : Executing validate...
[2013-10-07 17:46:55,303] INFO : [validate] started at: Mon Oct 07 17:46:55 NZDT 2013
[2013-10-07 17:46:56,604] INFO : Started SocketConnector@0.0.0.0:8080 STARTING
[2013-10-07 17:47:00,662] INFO : Using RAID engine Tx
[2013-10-07 17:47:10,463] INFO : Initiating FlexRAID Storage Pool...
[2013-10-07 17:47:10,964] INFO : Host OS = Microsoft Windows [Version 6.2.9200]
[2013-10-07 17:47:10,964] INFO : Building View Registry...
[2013-10-07 17:47:11,008] INFO : Building Auto View Registry...
[2013-10-07 17:47:11,046] INFO : Loading View options...
[2013-10-07 17:47:17,930] INFO : Using Auto-View definition...
[2013-10-07 17:47:17,930] INFO : Building View Handler...
[2013-10-07 17:47:21,143] INFO : Mounting Storage Pool drive...
[2013-10-07 17:47:41,791] INFO : Reconnecting "Storage Pool"="V:" /GRANT:Everyone,READ /GRANT:"Authenticated Users",FULL /GRANT:Administrators,FULL /GRANT:Administrator,FULL /GRANT:Bandit,FULL

Worth noting that just before the start of this log excerpt is the following:

Quote
[2013-10-07 03:00:00,661] INFO : Trigger update.HD Movies[update][Every Day at: 03:00:00
[Starting = null/null/null null:null:null]
[Ending = null/null/null null:null:null]] fired job HD Movies.HD Movies[update] at:  03:00:00 10/07/2013
[2013-10-07 03:00:00,950] INFO : Executing update...
[2013-10-07 03:00:01,037] INFO : [update] started at: Mon Oct 07 03:00:00 NZDT 2013
[2013-10-07 03:00:20,436] INFO : Using RAID engine Tx
[2013-10-07 03:00:44,212] ERROR: [update] error: OutOfMemoryError[Thread creation error: 8]
java.lang.OutOfMemoryError: Thread creation error: 8
   at java.lang.Void.<unknown>(Unknown Source)
   at java.lang.Void.<unknown>(Unknown Source)
   at java.lang.Void.<unknown>(Unknown Source)
   at java.lang.Void.<unknown>(Unknown Source)
[2013-10-07 03:00:44,230] INFO : [update] completed at: Mon Oct 07 03:00:44 NZDT 2013

After which the storage pool was no longer accessible, which is why I rebooted it in the first place.

Storage pool still inaccessible, so I'm getting concerned. Any ideas? Do these logs imply that Flexraid is simply still running the Validate?
« Last Edit: October 07, 2013, 12:55:23 am by morbandit »