[ 
https://issues.apache.org/jira/browse/AURORA-1587?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15102709#comment-15102709
 ] 

Zameer Manji commented on AURORA-1587:
--------------------------------------

I think this is also confusing because of the guice mangling as a result of not 
being on guice 4.0. Linking this to AURORA-1380

> scheduler fails in a hard to decipher way when -native_log_file_path is not 
> set
> -------------------------------------------------------------------------------
>
>                 Key: AURORA-1587
>                 URL: https://issues.apache.org/jira/browse/AURORA-1587
>             Project: Aurora
>          Issue Type: Bug
>          Components: Scheduler, Usability
>            Reporter: John Sirois
>
> As encountered by shirchen [and tracked down in 
> IRC|http://wilderness.apache.org/channels/?f=aurora/2016-01-15#1452898475], 
> scheduler starup failures due to a missing {{-native_log_file_path}} flag 
> value are confusing:
> {noformat}
> vagrant@debian-jessie:~$ sudo aurora-scheduler 
> -mesos_master_address=zk://localhost:2181/mesos/master -backup_dir 
> /var/lib/aurora/scheduler/backups -serverset_path=/aurora/scheduler 
> -cluster_name example -zk_endpoints=localhost:2181 
> -thermos_executor_path=/usr/share/aurora/bin/thermos_observer.pex -http_port 
> 8081
> Jan 15, 2016 10:00:31 PM org.apache.aurora.common.args.apt.Configuration load
> INFO: Loading @CmdLine config from: 
> [jar:file:/usr/share/aurora/lib/commons-0.12.0-SNAPSHOT.jar!/org/apache/aurora/common/args/apt/cmdline.arg.info.txt.1,
>  
> jar:file:/usr/share/aurora/lib/aurora-0.12.0-SNAPSHOT.jar!/org/apache/aurora/common/args/apt/cmdline.arg.info.txt.2]
> I0115 22:00:31.378 [main, Log:186] Logging initialized @744ms 
> W0115 22:00:31.558 [main, ArgScanner:318] Found argument name collisions, 
> args must be referenced by canonical names: [slow_query_log_threshold] 
> I0115 22:00:31.579 [main, ArgScanner:440] 
> ------------------------------------------------------------------------- 
> I0115 22:00:31.583 [main, ArgScanner:441] Command line argument values 
> I0115 22:00:31.584 [main, ArgScanner:443] allow_docker_parameters 
> (org.apache.aurora.scheduler.app.AppModule.allow_docker_parameters): false 
> I0115 22:00:31.585 [main, ArgScanner:443] allowed_container_types 
> (org.apache.aurora.scheduler.app.AppModule.allowed_container_types): [MESOS] 
> I0115 22:00:31.586 [main, ArgScanner:443] async_slot_stat_update_interval 
> (org.apache.aurora.scheduler.stats.AsyncStatsModule.async_slot_stat_update_interval):
>  (1, mins) 
> I0115 22:00:31.587 [main, ArgScanner:443] async_task_stat_update_interval 
> (org.apache.aurora.scheduler.stats.AsyncStatsModule.async_task_stat_update_interval):
>  (1, hrs) 
> I0115 22:00:31.587 [main, ArgScanner:443] async_worker_threads 
> (org.apache.aurora.scheduler.async.AsyncModule.async_worker_threads): 8 
> I0115 22:00:31.588 [main, ArgScanner:443] backup_dir 
> (org.apache.aurora.scheduler.storage.backup.BackupModule.backup_dir): 
> /var/lib/aurora/scheduler/backups 
> I0115 22:00:31.588 [main, ArgScanner:443] backup_interval 
> (org.apache.aurora.scheduler.storage.backup.BackupModule.backup_interval): 
> (1, hrs) 
> I0115 22:00:31.589 [main, ArgScanner:443] cluster_name 
> (org.apache.aurora.scheduler.app.SchedulerMain.cluster_name): example 
> I0115 22:00:31.589 [main, ArgScanner:443] cron_scheduler_num_threads 
> (org.apache.aurora.scheduler.cron.quartz.CronModule.cron_scheduler_num_threads):
>  100 
> I0115 22:00:31.590 [main, ArgScanner:443] cron_start_initial_backoff 
> (org.apache.aurora.scheduler.cron.quartz.CronModule.cron_start_initial_backoff):
>  (1, secs) 
> I0115 22:00:31.591 [main, ArgScanner:443] cron_start_max_backoff 
> (org.apache.aurora.scheduler.cron.quartz.CronModule.cron_start_max_backoff): 
> (1, mins) 
> I0115 22:00:31.591 [main, ArgScanner:443] cron_timezone 
> (org.apache.aurora.scheduler.cron.quartz.CronModule.cron_timezone): GMT 
> I0115 22:00:31.592 [main, ArgScanner:443] custom_executor_config 
> (org.apache.aurora.scheduler.configuration.executor.ExecutorModule.custom_executor_config):
>  null 
> I0115 22:00:31.596 [main, ArgScanner:443] db_row_gc_interval 
> (org.apache.aurora.scheduler.storage.db.DbModule.db_row_gc_interval): (2, 
> hrs) 
> I0115 22:00:31.597 [main, ArgScanner:443] dlog_max_entry_size 
> (org.apache.aurora.scheduler.storage.log.LogStorageModule.dlog_max_entry_size):
>  (512, KB) 
> I0115 22:00:31.598 [main, ArgScanner:443] dlog_shutdown_grace_period 
> (org.apache.aurora.scheduler.storage.log.LogStorageModule.dlog_shutdown_grace_period):
>  (2, secs) 
> I0115 22:00:31.598 [main, ArgScanner:443] dlog_snapshot_interval 
> (org.apache.aurora.scheduler.storage.log.LogStorageModule.dlog_snapshot_interval):
>  (1, hrs) 
> I0115 22:00:31.598 [main, ArgScanner:443] enable_cors_for 
> (org.apache.aurora.scheduler.http.api.ApiModule.enable_cors_for): null 
> I0115 22:00:31.599 [main, ArgScanner:443] enable_h2_console 
> (org.apache.aurora.scheduler.http.H2ConsoleModule.enable_h2_console): false 
> I0115 22:00:31.599 [main, ArgScanner:443] enable_preemptor 
> (org.apache.aurora.scheduler.preemptor.PreemptorModule.enable_preemptor): 
> true 
> I0115 22:00:31.600 [main, ArgScanner:443] executor_user 
> (org.apache.aurora.scheduler.mesos.CommandLineDriverSettingsModule.executor_user):
>  root 
> I0115 22:00:31.600 [main, ArgScanner:443] extra_modules 
> (org.apache.aurora.scheduler.app.SchedulerMain.extra_modules): [] 
> I0115 22:00:31.600 [main, ArgScanner:443] first_schedule_delay 
> (org.apache.aurora.scheduler.scheduling.SchedulingModule.first_schedule_delay):
>  (1, ms) 
> I0115 22:00:31.600 [main, ArgScanner:443] flapping_task_threshold 
> (org.apache.aurora.scheduler.scheduling.SchedulingModule.flapping_task_threshold):
>  (5, mins) 
> I0115 22:00:31.600 [main, ArgScanner:443] framework_announce_principal 
> (org.apache.aurora.scheduler.mesos.CommandLineDriverSettingsModule.framework_announce_principal):
>  false 
> I0115 22:00:31.600 [main, ArgScanner:443] framework_authentication_file 
> (org.apache.aurora.scheduler.mesos.CommandLineDriverSettingsModule.framework_authentication_file):
>  null 
> I0115 22:00:31.600 [main, ArgScanner:443] framework_failover_timeout 
> (org.apache.aurora.scheduler.mesos.CommandLineDriverSettingsModule.framework_failover_timeout):
>  (21, days) 
> I0115 22:00:31.600 [main, ArgScanner:443] global_container_mounts 
> (org.apache.aurora.scheduler.configuration.executor.ExecutorModule.global_container_mounts):
>  [] 
> I0115 22:00:31.601 [main, ArgScanner:443] history_max_per_job_threshold 
> (org.apache.aurora.scheduler.pruning.PruningModule.history_max_per_job_threshold):
>  100 
> I0115 22:00:31.601 [main, ArgScanner:443] history_min_retention_threshold 
> (org.apache.aurora.scheduler.pruning.PruningModule.history_min_retention_threshold):
>  (1, hrs) 
> I0115 22:00:31.601 [main, ArgScanner:443] history_prune_threshold 
> (org.apache.aurora.scheduler.pruning.PruningModule.history_prune_threshold): 
> (2, days) 
> I0115 22:00:31.601 [main, ArgScanner:443] hostname 
> (org.apache.aurora.scheduler.http.JettyServerModule.hostname): null 
> I0115 22:00:31.601 [main, ArgScanner:443] http_authentication_mechanism 
> (org.apache.aurora.scheduler.http.api.security.HttpSecurityModule.http_authentication_mechanism):
>  NONE 
> I0115 22:00:31.602 [main, ArgScanner:443] http_port 
> (org.apache.aurora.scheduler.http.JettyServerModule.http_port): 8081 
> I0115 22:00:31.602 [main, ArgScanner:443] initial_flapping_task_delay 
> (org.apache.aurora.scheduler.scheduling.SchedulingModule.initial_flapping_task_delay):
>  (30, secs) 
> I0115 22:00:31.602 [main, ArgScanner:443] initial_schedule_penalty 
> (org.apache.aurora.scheduler.scheduling.SchedulingModule.initial_schedule_penalty):
>  (1, secs) 
> I0115 22:00:31.602 [main, ArgScanner:443] initial_task_kill_retry_interval 
> (org.apache.aurora.scheduler.reconciliation.ReconciliationModule.initial_task_kill_retry_interval):
>  (5, secs) 
> I0115 22:00:31.602 [main, ArgScanner:443] 
> job_update_history_per_job_threshold 
> (org.apache.aurora.scheduler.pruning.PruningModule.job_update_history_per_job_threshold):
>  10 
> I0115 22:00:31.603 [main, ArgScanner:443] job_update_history_pruning_interval 
> (org.apache.aurora.scheduler.pruning.PruningModule.job_update_history_pruning_interval):
>  (15, mins) 
> I0115 22:00:31.603 [main, ArgScanner:443] 
> job_update_history_pruning_threshold 
> (org.apache.aurora.scheduler.pruning.PruningModule.job_update_history_pruning_threshold):
>  (30, days) 
> I0115 22:00:31.604 [main, ArgScanner:443] kerberos_debug 
> (org.apache.aurora.scheduler.http.api.security.Kerberos5ShiroRealmModule.kerberos_debug):
>  false 
> I0115 22:00:31.604 [main, ArgScanner:443] kerberos_server_keytab 
> (org.apache.aurora.scheduler.http.api.security.Kerberos5ShiroRealmModule.kerberos_server_keytab):
>  null 
> I0115 22:00:31.604 [main, ArgScanner:443] kerberos_server_principal 
> (org.apache.aurora.scheduler.http.api.security.Kerberos5ShiroRealmModule.kerberos_server_principal):
>  null 
> I0115 22:00:31.604 [main, ArgScanner:443] max_flapping_task_delay 
> (org.apache.aurora.scheduler.scheduling.SchedulingModule.max_flapping_task_delay):
>  (5, mins) 
> I0115 22:00:31.605 [main, ArgScanner:443] max_leading_duration 
> (org.apache.aurora.scheduler.SchedulerModule.max_leading_duration): (1, days) 
> I0115 22:00:31.605 [main, ArgScanner:443] max_registration_delay 
> (org.apache.aurora.scheduler.SchedulerModule.max_registration_delay): (1, 
> mins) 
> I0115 22:00:31.605 [main, ArgScanner:443] 
> max_reschedule_task_delay_on_startup 
> (org.apache.aurora.scheduler.scheduling.SchedulingModule.max_reschedule_task_delay_on_startup):
>  (30, secs) 
> I0115 22:00:31.605 [main, ArgScanner:443] max_saved_backups 
> (org.apache.aurora.scheduler.storage.backup.BackupModule.max_saved_backups): 
> 48 
> I0115 22:00:31.606 [main, ArgScanner:443] max_schedule_attempts_per_sec 
> (org.apache.aurora.scheduler.scheduling.SchedulingModule.max_schedule_attempts_per_sec):
>  40.0 
> I0115 22:00:31.607 [main, ArgScanner:443] max_schedule_penalty 
> (org.apache.aurora.scheduler.scheduling.SchedulingModule.max_schedule_penalty):
>  (1, mins) 
> I0115 22:00:31.608 [main, ArgScanner:443] max_status_update_batch_size 
> (org.apache.aurora.scheduler.SchedulerModule.max_status_update_batch_size): 
> 1000 
> I0115 22:00:31.609 [main, ArgScanner:443] max_tasks_per_job 
> (org.apache.aurora.scheduler.app.AppModule.max_tasks_per_job): 4000 
> I0115 22:00:31.610 [main, ArgScanner:443] max_update_instance_failures 
> (org.apache.aurora.scheduler.app.AppModule.max_update_instance_failures): 
> 20000 
> I0115 22:00:31.610 [main, ArgScanner:443] mesos_master_address 
> (org.apache.aurora.scheduler.mesos.CommandLineDriverSettingsModule.mesos_master_address):
>  zk://localhost:2181/mesos/master 
> I0115 22:00:31.610 [main, ArgScanner:443] mesos_role 
> (org.apache.aurora.scheduler.mesos.CommandLineDriverSettingsModule.mesos_role):
>  null 
> I0115 22:00:31.611 [main, ArgScanner:443] min_offer_hold_time 
> (org.apache.aurora.scheduler.offers.OffersModule.min_offer_hold_time): (5, 
> mins) 
> I0115 22:00:31.612 [main, ArgScanner:443] native_log_election_retries 
> (org.apache.aurora.scheduler.log.mesos.MesosLogStreamModule.native_log_election_retries):
>  20 
> I0115 22:00:31.612 [main, ArgScanner:443] native_log_election_timeout 
> (org.apache.aurora.scheduler.log.mesos.MesosLogStreamModule.native_log_election_timeout):
>  (15, secs) 
> I0115 22:00:31.612 [main, ArgScanner:443] native_log_file_path 
> (org.apache.aurora.scheduler.log.mesos.MesosLogStreamModule.native_log_file_path):
>  null 
> I0115 22:00:31.613 [main, ArgScanner:443] native_log_quorum_size 
> (org.apache.aurora.scheduler.log.mesos.MesosLogStreamModule.native_log_quorum_size):
>  1 
> I0115 22:00:31.613 [main, ArgScanner:443] native_log_read_timeout 
> (org.apache.aurora.scheduler.log.mesos.MesosLogStreamModule.native_log_read_timeout):
>  (5, secs) 
> I0115 22:00:31.614 [main, ArgScanner:443] native_log_write_timeout 
> (org.apache.aurora.scheduler.log.mesos.MesosLogStreamModule.native_log_write_timeout):
>  (3, secs) 
> I0115 22:00:31.616 [main, ArgScanner:443] native_log_zk_group_path 
> (org.apache.aurora.scheduler.log.mesos.MesosLogStreamModule.native_log_zk_group_path):
>  null 
> I0115 22:00:31.617 [main, ArgScanner:443] offer_hold_jitter_window 
> (org.apache.aurora.scheduler.offers.OffersModule.offer_hold_jitter_window): 
> (1, mins) 
> I0115 22:00:31.617 [main, ArgScanner:443] offer_reservation_duration 
> (org.apache.aurora.scheduler.scheduling.SchedulingModule.offer_reservation_duration):
>  (3, mins) 
> I0115 22:00:31.617 [main, ArgScanner:443] preemption_delay 
> (org.apache.aurora.scheduler.preemptor.PreemptorModule.preemption_delay): (3, 
> mins) 
> I0115 22:00:31.617 [main, ArgScanner:443] preemption_slot_hold_time 
> (org.apache.aurora.scheduler.preemptor.PreemptorModule.preemption_slot_hold_time):
>  (5, mins) 
> I0115 22:00:31.617 [main, ArgScanner:443] preemption_slot_search_interval 
> (org.apache.aurora.scheduler.preemptor.PreemptorModule.preemption_slot_search_interval):
>  (1, mins) 
> I0115 22:00:31.617 [main, ArgScanner:443] receive_revocable_resources 
> (org.apache.aurora.scheduler.mesos.CommandLineDriverSettingsModule.receive_revocable_resources):
>  false 
> I0115 22:00:31.617 [main, ArgScanner:443] reconciliation_explicit_interval 
> (org.apache.aurora.scheduler.reconciliation.ReconciliationModule.reconciliation_explicit_interval):
>  (60, mins) 
> I0115 22:00:31.618 [main, ArgScanner:443] reconciliation_implicit_interval 
> (org.apache.aurora.scheduler.reconciliation.ReconciliationModule.reconciliation_implicit_interval):
>  (60, mins) 
> I0115 22:00:31.618 [main, ArgScanner:443] reconciliation_initial_delay 
> (org.apache.aurora.scheduler.reconciliation.ReconciliationModule.reconciliation_initial_delay):
>  (1, mins) 
> I0115 22:00:31.618 [main, ArgScanner:443] reconciliation_schedule_spread 
> (org.apache.aurora.scheduler.reconciliation.ReconciliationModule.reconciliation_schedule_spread):
>  (30, mins) 
> I0115 22:00:31.618 [main, ArgScanner:443] serverset_path 
> (org.apache.aurora.scheduler.app.SchedulerMain.serverset_path): 
> /aurora/scheduler 
> I0115 22:00:31.618 [main, ArgScanner:443] shiro_ini_path 
> (org.apache.aurora.scheduler.http.api.security.IniShiroRealmModule.shiro_ini_path):
>  null 
> I0115 22:00:31.618 [main, ArgScanner:443] shiro_realm_modules 
> (org.apache.aurora.scheduler.http.api.security.HttpSecurityModule.shiro_realm_modules):
>  [org.apache.aurora.scheduler.app.MoreModules$1@411f53a0] 
> I0115 22:00:31.618 [main, ArgScanner:443] sla_non_prod_metrics 
> (org.apache.aurora.scheduler.sla.SlaModule.sla_non_prod_metrics): [] 
> I0115 22:00:31.618 [main, ArgScanner:443] sla_prod_metrics 
> (org.apache.aurora.scheduler.sla.SlaModule.sla_prod_metrics): [JOB_UPTIMES, 
> PLATFORM_UPTIME, MEDIANS] 
> I0115 22:00:31.618 [main, ArgScanner:443] sla_stat_refresh_interval 
> (org.apache.aurora.scheduler.sla.SlaModule.sla_stat_refresh_interval): (1, 
> mins) 
> I0115 22:00:31.618 [main, ArgScanner:443] slow_query_log_threshold 
> (org.apache.aurora.scheduler.storage.db.DbModule.slow_query_log_threshold): 
> (25, ms) 
> I0115 22:00:31.619 [main, ArgScanner:443] slow_query_log_threshold 
> (org.apache.aurora.scheduler.storage.mem.InMemStoresModule.slow_query_log_threshold):
>  (25, ms) 
> I0115 22:00:31.619 [main, ArgScanner:443] stat_retention_period 
> (org.apache.aurora.scheduler.stats.StatsModule.stat_retention_period): (1, 
> hrs) 
> I0115 22:00:31.619 [main, ArgScanner:443] stat_sampling_interval 
> (org.apache.aurora.scheduler.stats.StatsModule.stat_sampling_interval): (1, 
> secs) 
> I0115 22:00:31.619 [main, ArgScanner:443] thermos_executor_cpu 
> (org.apache.aurora.scheduler.configuration.executor.ExecutorModule.thermos_executor_cpu):
>  0.25 
> I0115 22:00:31.619 [main, ArgScanner:443] thermos_executor_flags 
> (org.apache.aurora.scheduler.configuration.executor.ExecutorModule.thermos_executor_flags):
>  null 
> I0115 22:00:31.620 [main, ArgScanner:443] thermos_executor_path 
> (org.apache.aurora.scheduler.configuration.executor.ExecutorModule.thermos_executor_path):
>  /usr/share/aurora/bin/thermos_observer.pex 
> I0115 22:00:31.620 [main, ArgScanner:443] thermos_executor_ram 
> (org.apache.aurora.scheduler.configuration.executor.ExecutorModule.thermos_executor_ram):
>  (128, MB) 
> I0115 22:00:31.620 [main, ArgScanner:443] thermos_executor_resources 
> (org.apache.aurora.scheduler.configuration.executor.ExecutorModule.thermos_executor_resources):
>  [] 
> I0115 22:00:31.620 [main, ArgScanner:443] thermos_observer_root 
> (org.apache.aurora.scheduler.configuration.executor.ExecutorModule.thermos_observer_root):
>  /var/run/thermos 
> I0115 22:00:31.621 [main, ArgScanner:443] tier_config 
> (org.apache.aurora.scheduler.SchedulerModule.tier_config): null 
> I0115 22:00:31.621 [main, ArgScanner:443] transient_task_state_timeout 
> (org.apache.aurora.scheduler.reconciliation.ReconciliationModule.transient_task_state_timeout):
>  (5, mins) 
> I0115 22:00:31.621 [main, ArgScanner:443] use_beta_db_task_store 
> (org.apache.aurora.scheduler.storage.db.DbModule.use_beta_db_task_store): 
> false 
> I0115 22:00:31.621 [main, ArgScanner:443] viz_job_url_prefix 
> (org.apache.aurora.scheduler.app.SchedulerMain.viz_job_url_prefix):  
> I0115 22:00:31.621 [main, ArgScanner:443] zk_chroot_path 
> (org.apache.aurora.scheduler.zookeeper.guice.client.flagged.FlaggedClientConfig.zk_chroot_path):
>  null 
> I0115 22:00:31.621 [main, ArgScanner:443] zk_digest_credentials 
> (org.apache.aurora.scheduler.zookeeper.guice.client.flagged.FlaggedClientConfig.zk_digest_credentials):
>  null 
> I0115 22:00:31.621 [main, ArgScanner:443] zk_endpoints 
> (org.apache.aurora.scheduler.zookeeper.guice.client.flagged.FlaggedClientConfig.zk_endpoints):
>  [localhost:2181] 
> I0115 22:00:31.621 [main, ArgScanner:443] zk_in_proc 
> (org.apache.aurora.scheduler.zookeeper.guice.client.flagged.FlaggedClientConfig.zk_in_proc):
>  false 
> I0115 22:00:31.622 [main, ArgScanner:443] zk_session_timeout 
> (org.apache.aurora.scheduler.zookeeper.guice.client.flagged.FlaggedClientConfig.zk_session_timeout):
>  (4, secs) 
> I0115 22:00:31.622 [main, ArgScanner:445] 
> ------------------------------------------------------------------------- 
> I0115 22:00:31.922 [main, PreemptorModule$1:87] Preemptor Enabled. 
> Jan 15, 2016 10:00:32 PM com.google.inject.internal.ProxyFactory <init>
> WARNING: Method [public java.lang.Iterable 
> org.apache.aurora.scheduler.storage.mem.MemTaskStore.fetchTasks(org.apache.aurora.scheduler.base.Query$Builder)]
>  is synthetic and is being intercepted by 
> [org.apache.aurora.common.inject.TimedInterceptor@2e11485]. This could 
> indicate a bug.  The method may be intercepted twice, or may not be 
> intercepted at all.
> Jan 15, 2016 10:00:32 PM com.google.inject.internal.ProxyFactory <init>
> WARNING: Method [public void 
> org.apache.aurora.scheduler.storage.log.SnapshotStoreImpl.applySnapshot(java.lang.Object)]
>  is synthetic and is being intercepted by 
> [org.apache.aurora.common.inject.TimedInterceptor@2e11485]. This could 
> indicate a bug.  The method may be intercepted twice, or may not be 
> intercepted at all.
> Jan 15, 2016 10:00:32 PM com.google.inject.internal.ProxyFactory <init>
> WARNING: Method [public java.lang.Object 
> org.apache.aurora.scheduler.storage.log.SnapshotStoreImpl.createSnapshot()] 
> is synthetic and is being intercepted by 
> [org.apache.aurora.common.inject.TimedInterceptor@2e11485]. This could 
> indicate a bug.  The method may be intercepted twice, or may not be 
> intercepted at all.
> W0115 22:00:33.535 [main, ServiceDiscoveryModule:61] Running without 
> ZooKeeper digest credentials. ZooKeeper ACLs are disabled. 
> I0115 22:00:33.641 [main, BuildInfo:68] Fetching build properties from 
> build.properties 
> I0115 22:00:33.844 [main, StdSchedulerFactory:1172] Using default 
> implementation for ThreadExecutor 
> I0115 22:00:33.866 [main, SchedulerSignalerImpl:61] Initialized Scheduler 
> Signaller of type: class org.quartz.core.SchedulerSignalerImpl 
> I0115 22:00:33.867 [main, QuartzScheduler:240] Quartz Scheduler v.2.2.2 
> created. 
> I0115 22:00:33.868 [main, RAMJobStore:155] RAMJobStore initialized. 
> I0115 22:00:33.870 [main, QuartzScheduler:305] Scheduler meta-data: Quartz 
> Scheduler (v2.2.2) 'QuartzScheduler' with instanceId 'aurora-cron-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 100 threads.
>   Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support 
> persistence. and is not clustered.
>  
> I0115 22:00:33.873 [main, StdSchedulerFactory:1327] Quartz scheduler 
> 'QuartzScheduler' initialized from an externally provided properties 
> instance. 
> I0115 22:00:33.873 [main, StdSchedulerFactory:1331] Quartz scheduler version: 
> 2.2.2 
> I0115 22:00:33.874 [main, QuartzScheduler:2311] JobFactory set to: 
> org.apache.aurora.scheduler.cron.quartz.AuroraCronJobFactory@5b56b654 
> W0115 22:00:33.878 [main, CronModule:102] Cron schedules are configured to 
> fire according to timezone Greenwich Mean Time but system timezone is set to 
> GMT+00:00 
> I0115 22:00:33.903 [main, BuildInfo:68] Fetching build properties from 
> build.properties 
> I0115 22:00:33.978 [TimeSeriesRepositoryImpl STARTING, 
> TimeSeriesRepositoryImpl:124] Build Info key: date has value Fri 2016-01-15 
> I0115 22:00:33.982 [RedirectMonitor STARTING, Environment:100] Client 
> environment:zookeeper.version=3.4.6-1569965, built on 02/20/2014 09:09 GMT 
> I0115 22:00:33.987 [RedirectMonitor STARTING, Environment:100] Client 
> environment:host.name=debian-jessie.vagrantup.com 
> I0115 22:00:33.987 [RedirectMonitor STARTING, Environment:100] Client 
> environment:java.version=1.8.0_66-internal 
> I0115 22:00:33.987 [RedirectMonitor STARTING, Environment:100] Client 
> environment:java.vendor=Oracle Corporation 
> I0115 22:00:33.988 [RedirectMonitor STARTING, Environment:100] Client 
> environment:java.home=/usr/lib/jvm/java-8-openjdk-amd64/jre 
> I0115 22:00:33.989 [RedirectMonitor STARTING, Environment:100] Client 
> environment:java.class.path=/usr/share/aurora/lib/aurora-0.12.0-SNAPSHOT.jar:/usr/share/aurora/lib/classes:/usr/share/aurora/lib/dependency-cache:/usr/share/aurora/lib/classes:/usr/share/aurora/lib/classes:/usr/share/aurora/lib/dependency-cache:/usr/share/aurora/lib/aurora-api-0.12.0-SNAPSHOT.jar:/usr/share/aurora/lib/commons-0.12.0-SNAPSHOT.jar:/usr/share/aurora/lib/commons-args-0.12.0-SNAPSHOT.jar:/usr/share/aurora/lib/aopalliance-1.0.jar:/usr/share/aurora/lib/logback-classic-1.1.3.jar:/usr/share/aurora/lib/jsr305-3.0.1.jar:/usr/share/aurora/lib/guice-3.0.jar:/usr/share/aurora/lib/guice-assistedinject-3.0.jar:/usr/share/aurora/lib/protobuf-java-2.6.1.jar:/usr/share/aurora/lib/h2-1.4.190.jar:/usr/share/aurora/lib/jackson-datatype-protobuf-0.9.3.jar:/usr/share/aurora/lib/jackson-core-2.5.1.jar:/usr/share/aurora/lib/jersey-core-1.19.jar:/usr/share/aurora/lib/jersey-json-1.19.jar:/usr/share/aurora/lib/jersey-server-1.19.jar:/usr/share/aurora/lib/jersey-servlet-1.19.jar:/usr/share/aurora/lib/jersey-guice-1.19.jar:/usr/share/aurora/lib/javax.inject-1.jar:/usr/share/aurora/lib/javax.servlet-api-3.1.0.jar:/usr/share/aurora/lib/stringtemplate-3.2.1.jar:/usr/share/aurora/lib/mesos-0.25.0.jar:/usr/share/aurora/lib/shiro-guice-1.2.4.jar:/usr/share/aurora/lib/shiro-web-1.2.4.jar:/usr/share/aurora/lib/zookeeper-3.4.6.jar:/usr/share/aurora/lib/jetty-rewrite-9.3.6.v20151106.jar:/usr/share/aurora/lib/jetty-server-9.3.6.v20151106.jar:/usr/share/aurora/lib/jetty-servlet-9.3.6.v20151106.jar:/usr/share/aurora/lib/jetty-servlets-9.3.6.v20151106.jar:/usr/share/aurora/lib/mybatis-3.3.0.jar:/usr/share/aurora/lib/mybatis-guice-3.7.jar:/usr/share/aurora/lib/quartz-2.2.2.jar:/usr/share/aurora/lib/forward-1.0.0.jar:/usr/share/aurora/lib/libthrift-0.9.1.jar:/usr/share/aurora/lib/gson-2.3.1.jar:/usr/share/aurora/lib/guava-19.0.jar:/usr/share/aurora/lib/guice-multibindings-3.0.jar:/usr/share/aurora/lib/commons-lang-2.6.jar:/usr/share/aurora/lib/joda-time-2.9.1.jar:/usr/share/aurora/lib/easymock-3.4.jar:/usr/share/aurora/lib/junit-4.12.jar:/usr/share/aurora/lib/logback-core-1.1.3.jar:/usr/share/aurora/lib/slf4j-api-1.7.7.jar:/usr/share/aurora/lib/cglib-2.2.1-v20090111.jar:/usr/share/aurora/lib/jackson-annotations-2.4.6.jar:/usr/share/aurora/lib/jackson-databind-2.4.6.jar:/usr/share/aurora/lib/annotations-3.0.0.jar:/usr/share/aurora/lib/jsr311-api-1.1.1.jar:/usr/share/aurora/lib/jettison-1.1.jar:/usr/share/aurora/lib/jaxb-impl-2.2.3-1.jar:/usr/share/aurora/lib/jackson-core-asl-1.9.2.jar:/usr/share/aurora/lib/jackson-mapper-asl-1.9.2.jar:/usr/share/aurora/lib/jackson-jaxrs-1.9.2.jar:/usr/share/aurora/lib/jackson-xc-1.9.2.jar:/usr/share/aurora/lib/guice-servlet-3.0.jar:/usr/share/aurora/lib/antlr-2.7.7.jar:/usr/share/aurora/lib/shiro-core-1.2.4.jar:/usr/share/aurora/lib/jline-0.9.94.jar:/usr/share/aurora/lib/netty-3.7.0.Final.jar:/usr/share/aurora/lib/jetty-client-9.3.6.v20151106.jar:/usr/share/aurora/lib/jetty-http-9.3.6.v20151106.jar:/usr/share/aurora/lib/jetty-io-9.3.6.v20151106.jar:/usr/share/aurora/lib/jetty-security-9.3.6.v20151106.jar:/usr/share/aurora/lib/jetty-continuation-9.3.6.v20151106.jar:/usr/share/aurora/lib/jetty-util-9.3.6.v20151106.jar:/usr/share/aurora/lib/c3p0-0.9.1.1.jar:/usr/share/aurora/lib/javapoet-1.4.0.jar:/usr/share/aurora/lib/commons-lang3-3.1.jar:/usr/share/aurora/lib/httpclient-4.2.5.jar:/usr/share/aurora/lib/httpcore-4.2.4.jar:/usr/share/aurora/lib/objenesis-2.2.jar:/usr/share/aurora/lib/hamcrest-core-1.3.jar:/usr/share/aurora/lib/asm-3.1.jar:/usr/share/aurora/lib/jaxb-api-2.2.2.jar:/usr/share/aurora/lib/commons-beanutils-1.8.3.jar:/usr/share/aurora/lib/commons-logging-1.1.1.jar:/usr/share/aurora/lib/commons-codec-1.6.jar:/usr/share/aurora/lib/stax-api-1.0-2.jar:/usr/share/aurora/lib/activation-1.1.jar
>  
> I0115 22:00:33.990 [RedirectMonitor STARTING, Environment:100] Client 
> environment:java.library.path=/usr/java/packages/lib/amd64:/usr/lib/x86_64-linux-gnu/jni:/lib/x86_64-linux-gnu:/usr/lib/x86_64-linux-gnu:/usr/lib/jni:/lib:/usr/lib
>  
> I0115 22:00:33.992 [TimeSeriesRepositoryImpl STARTING, 
> TimeSeriesRepositoryImpl:124] Build Info key: time has value 2016-01-15 
> 21:46:25 UTC 
> I0115 22:00:33.992 [RedirectMonitor STARTING, Environment:100] Client 
> environment:java.io.tmpdir=/tmp 
> I0115 22:00:33.995 [RedirectMonitor STARTING, Environment:100] Client 
> environment:java.compiler=<NA> 
> I0115 22:00:33.996 [RedirectMonitor STARTING, Environment:100] Client 
> environment:os.name=Linux 
> I0115 22:00:33.997 [RedirectMonitor STARTING, Environment:100] Client 
> environment:os.arch=amd64 
> I0115 22:00:33.997 [RedirectMonitor STARTING, Environment:100] Client 
> environment:os.version=3.16.0-4-amd64 
> I0115 22:00:33.997 [RedirectMonitor STARTING, Environment:100] Client 
> environment:user.name=root 
> I0115 22:00:33.998 [RedirectMonitor STARTING, Environment:100] Client 
> environment:user.home=/root 
> I0115 22:00:33.999 [RedirectMonitor STARTING, Environment:100] Client 
> environment:user.dir=/home/vagrant 
> I0115 22:00:33.999 [RedirectMonitor STARTING, ZooKeeper:438] Initiating 
> client connection, connectString=localhost:2181 sessionTimeout=4000 
> watcher=org.apache.aurora.common.zookeeper.ZooKeeperClient$$Lambda$121/1591681696@666bfc2c
>  
> I0115 22:00:34.056 [RedirectMonitor STARTING-SendThread(localhost:2181), 
> ClientCnxn$SendThread:975] Opening socket connection to server 
> localhost/127.0.0.1:2181. Will not attempt to authenticate using SASL 
> (unknown error) 
> I0115 22:00:34.076 [RedirectMonitor STARTING-SendThread(localhost:2181), 
> ClientCnxn$SendThread:852] Socket connection established to 
> localhost/127.0.0.1:2181, initiating session 
> I0115 22:00:34.087 [RedirectMonitor STARTING-SendThread(localhost:2181), 
> ClientCnxn$SendThread:1235] Session establishment complete on server 
> localhost/127.0.0.1:2181, sessionid = 0x1524729c3fa001a, negotiated timeout = 
> 4000 
> W0115 22:00:34.143 [RedirectMonitor STARTING, 
> ServerSetImpl$ServerSetWatcher:351] server set empty for path 
> /aurora/scheduler 
> W0115 22:00:34.156 [RedirectMonitor STARTING, 
> LeaderRedirect$SchedulerMonitor:203] No schedulers in host set, will not 
> redirect despite not being leader. 
> I0115 22:00:34.193 [HttpServerLauncher STARTING, Server:345] 
> jetty-9.3.6.v20151106 
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.api.ApiBeta as a root 
> resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.common.net.http.handlers.AbortHandler as 
> a root resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering 
> org.apache.aurora.common.net.http.handlers.ContentionPrinter as a root 
> resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.Cron as a root resource 
> class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.common.net.http.handlers.HealthHandler as 
> a root resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.Locks as a root resource 
> class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.LogConfig as a root 
> resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.Maintenance as a root 
> resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.Mname as a root resource 
> class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.Offers as a root resource 
> class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.PendingTasks as a root 
> resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.common.net.http.handlers.QuitHandler as a 
> root resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.Quotas as a root resource 
> class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.Services as a root 
> resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.Slaves as a root resource 
> class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.StructDump as a root 
> resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering 
> org.apache.aurora.common.net.http.handlers.ThreadStackPrinter as a root 
> resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering 
> org.apache.aurora.common.net.http.handlers.TimeSeriesDataSource as a root 
> resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.scheduler.http.Utilization as a root 
> resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.common.net.http.handlers.VarsHandler as a 
> root resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory register
> INFO: Registering org.apache.aurora.common.net.http.handlers.VarsJsonHandler 
> as a root resource class
> Jan 15, 2016 10:00:34 PM 
> com.sun.jersey.server.impl.application.WebApplicationImpl _initiate
> INFO: Initiating Jersey application, version 'Jersey: 1.19 02/11/2015 03:25 
> AM'
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.api.ApiBeta to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.common.net.http.handlers.AbortHandler to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.common.net.http.handlers.ContentionPrinter to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.Cron to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.common.net.http.handlers.HealthHandler to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.Locks to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.LogConfig to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.Maintenance to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.Mname to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.Offers to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.PendingTasks to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.common.net.http.handlers.QuitHandler to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.Quotas to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.Services to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.Slaves to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.StructDump to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.common.net.http.handlers.ThreadStackPrinter 
> to GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.common.net.http.handlers.TimeSeriesDataSource 
> to GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.scheduler.http.Utilization to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.common.net.http.handlers.VarsHandler to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> Jan 15, 2016 10:00:35 PM 
> com.sun.jersey.guice.spi.container.GuiceComponentProviderFactory 
> getComponentProvider
> INFO: Binding org.apache.aurora.common.net.http.handlers.VarsJsonHandler to 
> GuiceManagedComponentProvider with the scope "PerRequest"
> W0115 22:00:36.017 [HttpServerLauncher STARTING, CronModule:102] Cron 
> schedules are configured to fire according to timezone Greenwich Mean Time 
> but system timezone is set to GMT+00:00 
> I0115 22:00:36.061 [HttpServerLauncher STARTING, ContextHandler:775] Started 
> o.e.j.s.ServletContextHandler@3eff6aef{/,null,AVAILABLE} 
> I0115 22:00:36.078 [HttpServerLauncher STARTING, AbstractConnector:270] 
> Started ServerConnector@633e5fc7{HTTP/1.1,[http/1.1]}{0.0.0.0:8081} 
> I0115 22:00:36.079 [HttpServerLauncher STARTING, Server:397] Started @5452ms 
> I0115 22:00:36.084 [main, StateMachine$Builder:389] SchedulerLifecycle state 
> machine transition IDLE -> PREPARING_STORAGE 
> I0115 22:00:36.918 [main, SchedulerMain:193] Application run() exited. 
> I0115 22:00:36.918 [main, Lifecycle:84] Shutting down application 
> I0115 22:00:36.919 [main, ShutdownRegistry$ShutdownRegistryImpl:77] Executing 
> 2 shutdown commands. 
> I0115 22:00:36.921 [main, StateMachine$Builder:389] SchedulerLifecycle state 
> machine transition PREPARING_STORAGE -> DEAD 
> W0115 22:00:36.924 [main, ShutdownRegistry$ShutdownRegistryImpl:87] Shutdown 
> action failed. 
> org.apache.aurora.common.util.StateMachine$IllegalStateTransitionException: 
> State transition from CONSTRUCTED to STOPPED is not allowed.
>       at 
> org.apache.aurora.common.util.StateMachine.transition(StateMachine.java:153) 
> ~[commons-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.scheduler.storage.CallOrderEnforcingStorage.stop(CallOrderEnforcingStorage.java:107)
>  ~[aurora-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.scheduler.SchedulerLifecycle$7.execute(SchedulerLifecycle.java:313)
>  ~[aurora-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.scheduler.SchedulerLifecycle$7.execute(SchedulerLifecycle.java:287)
>  ~[aurora-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.common.base.Closures.lambda$filter$29(Closures.java:78) 
> ~[commons-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.common.base.Closures.lambda$combine$28(Closures.java:58) 
> ~[commons-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.common.util.StateMachine.transition(StateMachine.java:160) 
> ~[commons-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.scheduler.SchedulerLifecycle$3.execute(SchedulerLifecycle.java:227)
>  ~[aurora-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.common.application.ShutdownRegistry$ShutdownRegistryImpl.execute(ShutdownRegistry.java:85)
>  ~[commons-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.common.application.Lifecycle.shutdown(Lifecycle.java:85) 
> [commons-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.scheduler.app.SchedulerMain.flagConfiguredMain(SchedulerMain.java:197)
>  [aurora-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.scheduler.app.SchedulerMain.main(SchedulerMain.java:213) 
> [aurora-0.12.0-SNAPSHOT.jar:na]
> E0115 22:00:36.928 [main, SchedulerMain:162] Uncaught exception from 
> Thread[main,5,main]:com.google.inject.internal.util.$ComputationException: 
> java.lang.ArrayIndexOutOfBoundsException: 18299 
> com.google.inject.internal.util.$ComputationException: 
> java.lang.ArrayIndexOutOfBoundsException: 18299
>       at 
> com.google.inject.internal.util.$MapMaker$StrategyImpl.compute(MapMaker.java:553)
>  ~[guice-3.0.jar:na]
>       at 
> com.google.inject.internal.util.$MapMaker$StrategyImpl.compute(MapMaker.java:419)
>  ~[guice-3.0.jar:na]
>       at 
> com.google.inject.internal.util.$CustomConcurrentHashMap$ComputingImpl.get(CustomConcurrentHashMap.java:2041)
>  ~[guice-3.0.jar:na]
>       at 
> com.google.inject.internal.util.$StackTraceElements.forMember(StackTraceElements.java:53)
>  ~[guice-3.0.jar:na]
>       at com.google.inject.internal.Errors.formatSource(Errors.java:690) 
> ~[guice-3.0.jar:na]
>       at com.google.inject.internal.Errors.format(Errors.java:555) 
> ~[guice-3.0.jar:na]
>       at 
> com.google.inject.ProvisionException.getMessage(ProvisionException.java:59) 
> ~[guice-3.0.jar:na]
>       at java.lang.Throwable.getLocalizedMessage(Throwable.java:391) 
> ~[na:1.8.0_66-internal]
>       at java.lang.Throwable.toString(Throwable.java:480) 
> ~[na:1.8.0_66-internal]
>       at java.lang.String.valueOf(String.java:2994) ~[na:1.8.0_66-internal]
>       at java.lang.StringBuilder.append(StringBuilder.java:131) 
> ~[na:1.8.0_66-internal]
>       at 
> org.apache.aurora.scheduler.SchedulerLifecycle.lambda$dieOnError$38(SchedulerLifecycle.java:358)
>  ~[aurora-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.common.base.Closures.lambda$filter$29(Closures.java:78) 
> ~[commons-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.common.base.Closures.lambda$combine$28(Closures.java:58) 
> ~[commons-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.common.util.StateMachine.transition(StateMachine.java:160) 
> ~[commons-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.scheduler.SchedulerLifecycle.prepare(SchedulerLifecycle.java:373)
>  ~[aurora-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.scheduler.app.SchedulerMain.run(SchedulerMain.java:118) 
> ~[aurora-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.scheduler.app.SchedulerMain.flagConfiguredMain(SchedulerMain.java:191)
>  ~[aurora-0.12.0-SNAPSHOT.jar:na]
>       at 
> org.apache.aurora.scheduler.app.SchedulerMain.main(SchedulerMain.java:213) 
> ~[aurora-0.12.0-SNAPSHOT.jar:na]
> Caused by: java.lang.ArrayIndexOutOfBoundsException: 18299
>       at com.google.inject.internal.asm.$ClassReader.<init>(Unknown Source) 
> ~[guice-3.0.jar:na]
>       at com.google.inject.internal.asm.$ClassReader.<init>(Unknown Source) 
> ~[guice-3.0.jar:na]
>       at com.google.inject.internal.asm.$ClassReader.<init>(Unknown Source) 
> ~[guice-3.0.jar:na]
>       at 
> com.google.inject.internal.util.$LineNumbers.<init>(LineNumbers.java:62) 
> ~[guice-3.0.jar:na]
>       at 
> com.google.inject.internal.util.$StackTraceElements$1.apply(StackTraceElements.java:36)
>  ~[guice-3.0.jar:na]
>       at 
> com.google.inject.internal.util.$StackTraceElements$1.apply(StackTraceElements.java:33)
>  ~[guice-3.0.jar:na]
>       at 
> com.google.inject.internal.util.$MapMaker$StrategyImpl.compute(MapMaker.java:549)
>  ~[guice-3.0.jar:na]
>       ... 18 common frames omitted
> {noformat}
> This flag is defaulted to 
> [null|https://github.com/apache/aurora/blob/master/src/main/java/org/apache/aurora/scheduler/log/mesos/MesosLogStreamModule.java#L56-L59]
>  but no sanity checks are used [on 
> access|https://github.com/apache/aurora/blob/master/src/main/java/org/apache/aurora/scheduler/log/mesos/MesosLogStreamModule.java#L117-L129].
>   This leads to the confusing error presentation.



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)

Reply via email to