You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@geronimo.apache.org by "Jason Dillon (JIRA)" <ji...@apache.org> on 2007/06/14 18:56:26 UTC

[jira] Closed: (GERONIMO-1509) Maven logging output multipled

     [ https://issues.apache.org/jira/browse/GERONIMO-1509?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]

Jason Dillon closed GERONIMO-1509.
----------------------------------

       Resolution: Won't Fix
    Fix Version/s:     (was: 1.x)
         Assignee: Jason Dillon

Fixed in 1.2 and 2.0, 1.1.x is dormant.

> Maven logging output multipled
> ------------------------------
>
>                 Key: GERONIMO-1509
>                 URL: https://issues.apache.org/jira/browse/GERONIMO-1509
>             Project: Geronimo
>          Issue Type: Bug
>      Security Level: public(Regular issues) 
>          Components: buildsystem
>    Affects Versions: 1.0
>            Reporter: Aaron Mulder
>            Assignee: Jason Dillon
>            Priority: Minor
>
> 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:
> {noformat}
> 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] +----------------------------------------
> {noformat}
> 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:
> {noformat}
> 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] +----------------------------------------
> {noformat}

-- 
This message is automatically generated by JIRA.
-
You can reply to this email to add a comment to the issue online.