geronimo-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "John Sisson (JIRA)" <...@geronimo.apache.org>
Subject [jira] Commented: (GERONIMO-1509) Maven logging output multipled
Date Tue, 09 May 2006 01:56:24 GMT
    [ http://issues.apache.org/jira/browse/GERONIMO-1509?page=comments#action_12378552 ] 

John Sisson commented on GERONIMO-1509:
---------------------------------------

May be related to the following velocity issue:

http://marc.theaimsgroup.com/?t=114496678800005&r=1&w=2

> Maven logging output multipled
> ------------------------------
>
>          Key: GERONIMO-1509
>          URL: http://issues.apache.org/jira/browse/GERONIMO-1509
>      Project: Geronimo
>         Type: Bug
>     Security: public(Regular issues) 
>   Components: buildsystem
>     Versions: 1.0
>     Reporter: Aaron Mulder
>     Priority: Minor
>      Fix For: 1.x

>
> When I run a new Maven build on the 1.0 branch...
> It starts out printing each Maven log message once...
> By the time it gets to the Transaction module, it's printing each one twice:
> 23:09:54,922 INFO  [ReactorTag] +----------------------------------------
> 23:09:54,922 INFO  [ReactorTag] +----------------------------------------
> | geronimo and geronimo-plugins Geronimo :: Transaction
> 23:09:54,922 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Transaction
> 23:09:54,922 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Transaction
> | Memory: 24M/66M
> 23:09:54,923 INFO  [ReactorTag] | Memory: 24M/66M
> 23:09:54,923 INFO  [ReactorTag] | Memory: 24M/66M
> +----------------------------------------
> 23:09:54,924 INFO  [ReactorTag] +----------------------------------------
> 23:09:54,924 INFO  [ReactorTag] +----------------------------------------
> Something right there causes it to really get out of hand (see below).  I wonder if the
Transaction tests are manipulating the Log4J configuration?  It looks like there are 8 transaction
tests and the log output goes from repeated twice to repeated 10 times (a difference of 8...
kind of makes you go "hmmm"...).  Someone should look into this.  If we ID the issue in the
transaction tests, maybe we can figure out what's causing it to get from 1 to 2 and so on.
 Anyway, here's the suspicious output from the transaction build:
> multiproject:install-callback:
>     [echo] Running jar:install for Geronimo :: Transaction
> java:prepare-filesystem:
>     [mkdir] Created dir: /data/cvs/geronimo-1.0-branch/modules/transaction/target/classes
> java:compile:
> <depend closure="false" srcdir="1.4" dump="false" destdir="/data/cvs/geronimo-1.0-branch/modules/transaction/target/classes"></depend>
   [echo] Compiling to /data/cvs/geronimo-1.0-branch/modules/transaction/target/classes
>     [javac] Compiling 40 source files to /data/cvs/geronimo-1.0-branch/modules/transaction/target/classes
> java:jar-resources:
> test:prepare-filesystem:
>     [mkdir] Created dir: /data/cvs/geronimo-1.0-branch/modules/transaction/target/test-classes
>     [mkdir] Created dir: /data/cvs/geronimo-1.0-branch/modules/transaction/target/test-reports
> test:test-resources:
> test:compile:
>     [javac] Compiling 15 source files to /data/cvs/geronimo-1.0-branch/modules/transaction/target/test-classes
> test:test:
>     [junit] Running org.apache.geronimo.transaction.context.TransactionContextManagerTest
>     [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.121 sec
>     [junit] Running org.apache.geronimo.transaction.log.HOWLLogTest
>     [junit] Tests run: 2, Failures: 0, Errors: 0, Time elapsed: 8.094 sec
>     [junit] Running org.apache.geronimo.transaction.manager.HOWLLogRecoveryTest
>     [junit] Tests run: 5, Failures: 0, Errors: 0, Time elapsed: 2.954 sec
>     [junit] Running org.apache.geronimo.transaction.manager.MockLogRecoveryTest
>     [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.075 sec
>     [junit] Running org.apache.geronimo.transaction.manager.ProtocolTest
>     [junit] Tests run: 4, Failures: 0, Errors: 0, Time elapsed: 0.113 sec
>     [junit] Running org.apache.geronimo.transaction.manager.RecoveryTest
>     [junit] Tests run: 3, Failures: 0, Errors: 0, Time elapsed: 0.073 sec
>     [junit] Running org.apache.geronimo.transaction.manager.TransactionManagerImplTest
>     [junit] Tests run: 14, Failures: 0, Errors: 0, Time elapsed: 15.164 sec
>     [junit] Running org.apache.geronimo.transaction.manager.XidImporterTest
>     [junit] Tests run: 8, Failures: 0, Errors: 0, Time elapsed: 0.114 sec
> Running post goal: test:test
> 23:10:25,440 INFO  [PostGoalTag] Running post goal: test:test
> 23:10:25,440 INFO  [PostGoalTag] Running post goal: test:test
> 23:10:25,440 INFO  [PostGoalTag] Running post goal: test:test
> 23:10:25,440 INFO  [PostGoalTag] Running post goal: test:test
> 23:10:25,440 INFO  [PostGoalTag] Running post goal: test:test
> 23:10:25,440 INFO  [PostGoalTag] Running post goal: test:test
> 23:10:25,440 INFO  [PostGoalTag] Running post goal: test:test
> 23:10:25,440 INFO  [PostGoalTag] Running post goal: test:test
> 23:10:25,440 INFO  [PostGoalTag] Running post goal: test:test
> 23:10:25,440 INFO  [PostGoalTag] Running post goal: test:test
>     [touch] Creating /data/cvs/geronimo-1.0-branch/modules/transaction/target/test-reports/tstamp
> jar:jar:
>     [jar] Building jar: /data/cvs/geronimo-1.0-branch/modules/transaction/target/geronimo-transaction-1.0.1-SNAPSHOT.jar
> jar:install:
>     [echo] Installing...
> Uploading to geronimo/jars/geronimo-transaction-1.0.1-SNAPSHOT.jar:
> .................... (73K)
> Uploading to geronimo/poms/geronimo-transaction-1.0.1-SNAPSHOT.pom:
> .................... (12K)
> +----------------------------------------
> build:end:
> 23:10:26,145 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,145 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,145 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,145 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,145 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,145 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,145 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,145 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,145 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,145 INFO  [ReactorTag] +----------------------------------------
> | geronimo and geronimo-plugins Geronimo :: Connector
> 23:10:26,148 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Connector
> 23:10:26,148 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Connector
> 23:10:26,148 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Connector
> 23:10:26,148 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Connector
> 23:10:26,148 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Connector
> 23:10:26,148 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Connector
> 23:10:26,148 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Connector
> 23:10:26,148 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Connector
> 23:10:26,148 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Connector
> 23:10:26,148 INFO  [ReactorTag] | geronimo and geronimo-plugins Geronimo :: Connector
> | Memory: 26M/66M
> 23:10:26,151 INFO  [ReactorTag] | Memory: 26M/66M
> 23:10:26,151 INFO  [ReactorTag] | Memory: 26M/66M
> 23:10:26,151 INFO  [ReactorTag] | Memory: 26M/66M
> 23:10:26,151 INFO  [ReactorTag] | Memory: 26M/66M
> 23:10:26,151 INFO  [ReactorTag] | Memory: 26M/66M
> 23:10:26,151 INFO  [ReactorTag] | Memory: 26M/66M
> 23:10:26,151 INFO  [ReactorTag] | Memory: 26M/66M
> 23:10:26,151 INFO  [ReactorTag] | Memory: 26M/66M
> 23:10:26,151 INFO  [ReactorTag] | Memory: 26M/66M
> 23:10:26,151 INFO  [ReactorTag] | Memory: 26M/66M
> +----------------------------------------
> 23:10:26,153 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,153 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,153 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,153 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,153 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,153 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,153 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,153 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,153 INFO  [ReactorTag] +----------------------------------------
> 23:10:26,153 INFO  [ReactorTag] +----------------------------------------

-- 
This message is automatically generated by JIRA.
-
If you think it was sent incorrectly contact one of the administrators:
   http://issues.apache.org/jira/secure/Administrators.jspa
-
For more information on JIRA, see:
   http://www.atlassian.com/software/jira


Mime
View raw message