Return-Path: Delivered-To: apmail-geronimo-dev-archive@www.apache.org Received: (qmail 56353 invoked from network); 8 May 2006 17:54:06 -0000 Received: from hermes.apache.org (HELO mail.apache.org) (209.237.227.199) by minotaur.apache.org with SMTP; 8 May 2006 17:54:06 -0000 Received: (qmail 52993 invoked by uid 500); 8 May 2006 17:54:03 -0000 Delivered-To: apmail-geronimo-dev-archive@geronimo.apache.org Received: (qmail 52940 invoked by uid 500); 8 May 2006 17:54:02 -0000 Mailing-List: contact dev-help@geronimo.apache.org; run by ezmlm Precedence: bulk list-help: list-unsubscribe: List-Post: Reply-To: dev@geronimo.apache.org List-Id: Delivered-To: mailing list dev@geronimo.apache.org Received: (qmail 52929 invoked by uid 99); 8 May 2006 17:54:02 -0000 Received: from asf.osuosl.org (HELO asf.osuosl.org) (140.211.166.49) by apache.org (qpsmtpd/0.29) with ESMTP; Mon, 08 May 2006 10:54:02 -0700 X-ASF-Spam-Status: No, hits=0.0 required=10.0 tests= X-Spam-Check-By: apache.org Received: from [209.237.227.198] (HELO brutus.apache.org) (209.237.227.198) by apache.org (qpsmtpd/0.29) with ESMTP; Mon, 08 May 2006 10:54:01 -0700 Received: from brutus (localhost [127.0.0.1]) by brutus.apache.org (Postfix) with ESMTP id 4152B714296 for ; Mon, 8 May 2006 17:53:21 +0000 (GMT) Message-ID: <25390252.1147110801264.JavaMail.jira@brutus> Date: Mon, 8 May 2006 17:53:21 +0000 (GMT+00:00) From: "David Jencks (JIRA)" To: dev@geronimo.apache.org Subject: [jira] Updated: (GERONIMO-1509) Maven logging output multipled In-Reply-To: <199239144.1137730661999.JavaMail.jira@ajax.apache.org> MIME-Version: 1.0 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: 7bit X-Virus-Checked: Checked by ClamAV on apache.org X-Spam-Rating: minotaur.apache.org 1.6.2 0/1000/N [ http://issues.apache.org/jira/browse/GERONIMO-1509?page=all ] David Jencks updated GERONIMO-1509: ----------------------------------- Component: buildsystem (was: transaction manager) Until determined otherwise, this is a build system issue. Hopefully it will go away with the m2 build > 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: > [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