You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@drill.apache.org by Bob Rumsby <br...@maprtech.com> on 2014/11/10 02:26:26 UTC
Logging errors with Drill 0.6
I installed 0.6 in embedded mode on my MacBook. sqlline eventually starts
but only after returning extensive logback errors. Let me know if I should
open a JIRA. I don't remember having this problem with 0.5 and earlier.
Thanks,
Bob
adminisrsmbp149:apache-drill-0.6.0-incubating brumsby$ bin/sqlline -u
jdbc:drill:zk=local -n admin -p admin
17:20:11,625 |-INFO in ch.qos.logback.classic.LoggerContext[default] -
Could NOT find resource [logback.groovy]
17:20:11,625 |-INFO in ch.qos.logback.classic.LoggerContext[default] -
Could NOT find resource [logback-test.xml]
17:20:11,626 |-INFO in ch.qos.logback.classic.LoggerContext[default] -
Found resource [logback.xml] at
[file:/Users/brumsby/drill/apache-drill-0.6.0-incubating/conf/logback.xml]
17:20:11,780 |-INFO in
ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute
not set
17:20:27,135 |-INFO in ch.qos.logback.core.joran.action.AppenderAction -
About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
17:20:27,148 |-INFO in ch.qos.logback.core.joran.action.AppenderAction -
Naming appender as [STDOUT]
17:20:27,172 |-INFO in
ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default
type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder]
property
17:20:27,237 |-INFO in ch.qos.logback.core.joran.action.AppenderAction -
About to instantiate appender of type
[ch.qos.logback.core.rolling.RollingFileAppender]
17:20:27,240 |-INFO in ch.qos.logback.core.joran.action.AppenderAction -
Naming appender as [FILE]
17:20:27,259 |-INFO in
ch.qos.logback.core.rolling.FixedWindowRollingPolicy@57c70722 - No
compression will be used
17:20:27,266 |-INFO in
ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default
type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder]
property
17:20:27,267 |-INFO in
ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file
name: /var/log/drill/sqlline.log
17:20:27,267 |-INFO in
ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is
set to [/var/log/drill/sqlline.log]
17:20:27,269 |-ERROR in
ch.qos.logback.core.rolling.RollingFileAppender[FILE] -
openFile(/var/log/drill/sqlline.log,true) call failed.
java.io.FileNotFoundException: /var/log/drill/sqlline.log (Permission
denied)
at java.io.FileNotFoundException: /var/log/drill/sqlline.log (Permission
denied)
at at java.io.FileOutputStream.open(Native Method)
at at java.io.FileOutputStream.<init>(FileOutputStream.java:221)
at at
ch.qos.logback.core.recovery.ResilientFileOutputStream.<init>(ResilientFileOutputStream.java:28)
at at ch.qos.logback.core.FileAppender.openFile(FileAppender.java:149)
at at ch.qos.logback.core.FileAppender.start(FileAppender.java:108)
at at
ch.qos.logback.core.rolling.RollingFileAppender.start(RollingFileAppender.java:86)
at at
ch.qos.logback.core.joran.action.AppenderAction.end(AppenderAction.java:96)
at at
ch.qos.logback.core.joran.spi.Interpreter.callEndAction(Interpreter.java:317)
at at
ch.qos.logback.core.joran.spi.Interpreter.endElement(Interpreter.java:196)
at at
ch.qos.logback.core.joran.spi.Interpreter.endElement(Interpreter.java:182)
at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:62)
at at
ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:149)
at at
ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:135)
at at
ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:99)
at at
ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:49)
at at
ch.qos.logback.classic.util.ContextInitializer.configureByResource(ContextInitializer.java:75)
at at
ch.qos.logback.classic.util.ContextInitializer.autoConfig(ContextInitializer.java:148)
at at org.slf4j.impl.StaticLoggerBinder.init(StaticLoggerBinder.java:85)
at at org.slf4j.impl.StaticLoggerBinder.<clinit>(StaticLoggerBinder.java:55)
at at org.slf4j.LoggerFactory.bind(LoggerFactory.java:128)
at at org.slf4j.LoggerFactory.performInitialization(LoggerFactory.java:107)
at at org.slf4j.LoggerFactory.getILoggerFactory(LoggerFactory.java:295)
at at org.slf4j.LoggerFactory.getLogger(LoggerFactory.java:269)
at at org.slf4j.LoggerFactory.getLogger(LoggerFactory.java:281)
at at
org.apache.drill.jdbc.DrillConnectionImpl.<clinit>(DrillConnectionImpl.java:52)
at at
org.apache.drill.jdbc.DrillJdbc41Factory.newDrillConnection(DrillJdbc41Factory.java:57)
at at
org.apache.drill.jdbc.DrillJdbc41Factory.newDrillConnection(DrillJdbc41Factory.java:43)
at at org.apache.drill.jdbc.DrillFactory.newConnection(DrillFactory.java:51)
at at
net.hydromatic.avatica.UnregisteredDriver.connect(UnregisteredDriver.java:126)
at at sqlline.SqlLine$DatabaseConnection.connect(SqlLine.java:4732)
at at sqlline.SqlLine$DatabaseConnection.getConnection(SqlLine.java:4786)
at at sqlline.SqlLine$Commands.connect(SqlLine.java:4026)
at at sqlline.SqlLine$Commands.connect(SqlLine.java:3935)
at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at at java.lang.reflect.Method.invoke(Method.java:606)
at at sqlline.SqlLine$ReflectiveCommandHandler.execute(SqlLine.java:2884)
at at sqlline.SqlLine.dispatch(SqlLine.java:885)
at at sqlline.SqlLine.initArgs(SqlLine.java:693)
at at sqlline.SqlLine.begin(SqlLine.java:745)
at at sqlline.SqlLine.start(SqlLine.java:498)
at at sqlline.SqlLine.main(SqlLine.java:460)
17:20:27,269 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction -
Setting additivity of logger [org.apache.drill] to false
17:20:27,269 |-INFO in ch.qos.logback.classic.joran.action.LevelAction -
org.apache.drill level set to INFO
17:20:27,270 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction -
Attaching appender named [FILE] to Logger[org.apache.drill]
17:20:27,270 |-INFO in ch.qos.logback.classic.joran.action.LevelAction -
ROOT level set to ERROR
17:20:27,270 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction -
Attaching appender named [STDOUT] to Logger[ROOT]
17:20:27,270 |-INFO in
ch.qos.logback.classic.joran.action.ConfigurationAction - End of
configuration.
17:20:27,271 |-INFO in
ch.qos.logback.classic.joran.JoranConfigurator@632c17b6 - Registering
current configuration as safe fallback point
Nov 09, 2014 5:20:53 PM org.glassfish.jersey.server.ApplicationHandler
initialize
INFO: Initiating Jersey application, version Jersey: 2.8 2014-04-29
01:25:26...
sqlline version 1.1.6
0: jdbc:drill:zk=local> use dfs;
+------------+------------+
| ok | summary |
+------------+------------+
| true | Default schema changed to 'dfs' |
+------------+------------+
1 row selected (0.75 seconds)
Re: Logging errors with Drill 0.6
Posted by Jason Altekruse <al...@gmail.com>.
Hi Bob,
Looking in the output there is this line "java.io.FileNotFoundException:
/var/log/drill/sqlline.log". The logging directory for drill is user
configurable. It looks like this file is not on the machine, you can try to
go into the conf directory of your install and edit the logback.xml file to
set a different directory, or just create the logging file in the location
its currently looking. I assume you will need to make the logging file
writable by whatever user you run the drillbit process as.
-Jason
On Sun, Nov 9, 2014 at 5:26 PM, Bob Rumsby <br...@maprtech.com> wrote:
> I installed 0.6 in embedded mode on my MacBook. sqlline eventually starts
> but only after returning extensive logback errors. Let me know if I should
> open a JIRA. I don't remember having this problem with 0.5 and earlier.
>
> Thanks,
> Bob
>
> adminisrsmbp149:apache-drill-0.6.0-incubating brumsby$ bin/sqlline -u
> jdbc:drill:zk=local -n admin -p admin
> 17:20:11,625 |-INFO in ch.qos.logback.classic.LoggerContext[default] -
> Could NOT find resource [logback.groovy]
> 17:20:11,625 |-INFO in ch.qos.logback.classic.LoggerContext[default] -
> Could NOT find resource [logback-test.xml]
> 17:20:11,626 |-INFO in ch.qos.logback.classic.LoggerContext[default] -
> Found resource [logback.xml] at
> [file:/Users/brumsby/drill/apache-drill-0.6.0-incubating/conf/logback.xml]
> 17:20:11,780 |-INFO in
> ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute
> not set
> 17:20:27,135 |-INFO in ch.qos.logback.core.joran.action.AppenderAction -
> About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
> 17:20:27,148 |-INFO in ch.qos.logback.core.joran.action.AppenderAction -
> Naming appender as [STDOUT]
> 17:20:27,172 |-INFO in
> ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default
> type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder]
> property
> 17:20:27,237 |-INFO in ch.qos.logback.core.joran.action.AppenderAction -
> About to instantiate appender of type
> [ch.qos.logback.core.rolling.RollingFileAppender]
> 17:20:27,240 |-INFO in ch.qos.logback.core.joran.action.AppenderAction -
> Naming appender as [FILE]
> 17:20:27,259 |-INFO in
> ch.qos.logback.core.rolling.FixedWindowRollingPolicy@57c70722 - No
> compression will be used
> 17:20:27,266 |-INFO in
> ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default
> type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder]
> property
> 17:20:27,267 |-INFO in
> ch.qos.logback.core.rolling.RollingFileAppender[FILE] - Active log file
> name: /var/log/drill/sqlline.log
> 17:20:27,267 |-INFO in
> ch.qos.logback.core.rolling.RollingFileAppender[FILE] - File property is
> set to [/var/log/drill/sqlline.log]
> 17:20:27,269 |-ERROR in
> ch.qos.logback.core.rolling.RollingFileAppender[FILE] -
> openFile(/var/log/drill/sqlline.log,true) call failed.
> java.io.FileNotFoundException: /var/log/drill/sqlline.log (Permission
> denied)
> at java.io.FileNotFoundException: /var/log/drill/sqlline.log (Permission
> denied)
> at at java.io.FileOutputStream.open(Native Method)
> at at java.io.FileOutputStream.<init>(FileOutputStream.java:221)
> at at
>
> ch.qos.logback.core.recovery.ResilientFileOutputStream.<init>(ResilientFileOutputStream.java:28)
> at at ch.qos.logback.core.FileAppender.openFile(FileAppender.java:149)
> at at ch.qos.logback.core.FileAppender.start(FileAppender.java:108)
> at at
>
> ch.qos.logback.core.rolling.RollingFileAppender.start(RollingFileAppender.java:86)
> at at
> ch.qos.logback.core.joran.action.AppenderAction.end(AppenderAction.java:96)
> at at
>
> ch.qos.logback.core.joran.spi.Interpreter.callEndAction(Interpreter.java:317)
> at at
> ch.qos.logback.core.joran.spi.Interpreter.endElement(Interpreter.java:196)
> at at
> ch.qos.logback.core.joran.spi.Interpreter.endElement(Interpreter.java:182)
> at at ch.qos.logback.core.joran.spi.EventPlayer.play(EventPlayer.java:62)
> at at
>
> ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:149)
> at at
>
> ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:135)
> at at
>
> ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:99)
> at at
>
> ch.qos.logback.core.joran.GenericConfigurator.doConfigure(GenericConfigurator.java:49)
> at at
>
> ch.qos.logback.classic.util.ContextInitializer.configureByResource(ContextInitializer.java:75)
> at at
>
> ch.qos.logback.classic.util.ContextInitializer.autoConfig(ContextInitializer.java:148)
> at at org.slf4j.impl.StaticLoggerBinder.init(StaticLoggerBinder.java:85)
> at at
> org.slf4j.impl.StaticLoggerBinder.<clinit>(StaticLoggerBinder.java:55)
> at at org.slf4j.LoggerFactory.bind(LoggerFactory.java:128)
> at at org.slf4j.LoggerFactory.performInitialization(LoggerFactory.java:107)
> at at org.slf4j.LoggerFactory.getILoggerFactory(LoggerFactory.java:295)
> at at org.slf4j.LoggerFactory.getLogger(LoggerFactory.java:269)
> at at org.slf4j.LoggerFactory.getLogger(LoggerFactory.java:281)
> at at
>
> org.apache.drill.jdbc.DrillConnectionImpl.<clinit>(DrillConnectionImpl.java:52)
> at at
>
> org.apache.drill.jdbc.DrillJdbc41Factory.newDrillConnection(DrillJdbc41Factory.java:57)
> at at
>
> org.apache.drill.jdbc.DrillJdbc41Factory.newDrillConnection(DrillJdbc41Factory.java:43)
> at at
> org.apache.drill.jdbc.DrillFactory.newConnection(DrillFactory.java:51)
> at at
>
> net.hydromatic.avatica.UnregisteredDriver.connect(UnregisteredDriver.java:126)
> at at sqlline.SqlLine$DatabaseConnection.connect(SqlLine.java:4732)
> at at sqlline.SqlLine$DatabaseConnection.getConnection(SqlLine.java:4786)
> at at sqlline.SqlLine$Commands.connect(SqlLine.java:4026)
> at at sqlline.SqlLine$Commands.connect(SqlLine.java:3935)
> at at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at at
>
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
> at at
>
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at at java.lang.reflect.Method.invoke(Method.java:606)
> at at sqlline.SqlLine$ReflectiveCommandHandler.execute(SqlLine.java:2884)
> at at sqlline.SqlLine.dispatch(SqlLine.java:885)
> at at sqlline.SqlLine.initArgs(SqlLine.java:693)
> at at sqlline.SqlLine.begin(SqlLine.java:745)
> at at sqlline.SqlLine.start(SqlLine.java:498)
> at at sqlline.SqlLine.main(SqlLine.java:460)
> 17:20:27,269 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction -
> Setting additivity of logger [org.apache.drill] to false
> 17:20:27,269 |-INFO in ch.qos.logback.classic.joran.action.LevelAction -
> org.apache.drill level set to INFO
> 17:20:27,270 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction -
> Attaching appender named [FILE] to Logger[org.apache.drill]
> 17:20:27,270 |-INFO in ch.qos.logback.classic.joran.action.LevelAction -
> ROOT level set to ERROR
> 17:20:27,270 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction -
> Attaching appender named [STDOUT] to Logger[ROOT]
> 17:20:27,270 |-INFO in
> ch.qos.logback.classic.joran.action.ConfigurationAction - End of
> configuration.
> 17:20:27,271 |-INFO in
> ch.qos.logback.classic.joran.JoranConfigurator@632c17b6 - Registering
> current configuration as safe fallback point
>
> Nov 09, 2014 5:20:53 PM org.glassfish.jersey.server.ApplicationHandler
> initialize
> INFO: Initiating Jersey application, version Jersey: 2.8 2014-04-29
> 01:25:26...
>
> sqlline version 1.1.6
> 0: jdbc:drill:zk=local> use dfs;
> +------------+------------+
> | ok | summary |
> +------------+------------+
> | true | Default schema changed to 'dfs' |
> +------------+------------+
> 1 row selected (0.75 seconds)
>