[infinispan-issues] [JBoss JIRA] (ISPN-3081) Logging produces strange beginning of lines

Tue May 7 08:05:53 EDT 2013

    [ https://issues.jboss.org/browse/ISPN-3081?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=12772638#comment-12772638 ] 

Michal Linhard commented on ISPN-3081:
--------------------------------------

seems like the problem is only in few first logged lines:
{code}
JAVA_OPTS already set in environment; overriding default settings with values: -Djava.managed.server.id=p3MXeYznB29SpGQJ -server -Xms256m -Xmx256m -XX:MaxPermSize=128m -XX:MaxDirectMemorySize=64m -XX:+UseLargePages -Dsun.nio.ch.bugLevel= -Djava.net.preferIPv4Stack=true -XX:NewRatio=3 -XX:+UseConcMarkSweepGC -XX:+UseParNewGC  -Dorg.jboss.qa.threadpoolwatchdog.output=/home/mlinhard/dev/projects/perf/smartfrog/smartfrog/tpstats/node01.csv
=========================================================================

  JBoss Bootstrap Environment

  JBOSS_HOME: /home/mlinhard/dev/projects/perf/smartfrog/smartfrog/servers/node01

  JAVA: /home/mlinhard/dev/software/jdk1.6.0_37/bin/java

  JAVA_OPTS:  -Djava.managed.server.id=p3MXeYznB29SpGQJ -server -Xms256m -Xmx256m -XX:MaxPermSize=128m -XX:MaxDirectMemorySize=64m -XX:+UseLargePages -Dsun.nio.ch.bugLevel= -Djava.net.preferIPv4Stack=true -XX:NewRatio=3 -XX:+UseConcMarkSweepGC -XX:+UseParNewGC  -Dorg.jboss.qa.threadpoolwatchdog.output=/home/mlinhard/dev/projects/perf/smartfrog/smartfrog/tpstats/node01.csv

=========================================================================

Java HotSpot(TM) Server VM warning: Failed to reserve shared memory (errno = 22).
[0m14:03:31,945 INFO  [org.jboss.modules] (main) JBoss Modules version 1.2.0.CR1
[0m[0m14:03:32,331 INFO  [org.jboss.msc] (main) JBoss MSC version 1.0.4.GA
[0m[0m14:03:32,602 INFO  [org.jboss.as] (MSC service thread 1-3) JBAS015899: JBoss Infinispan Server 5.3.0-SNAPSHOT (AS 7.2.0.Final) starting
[0m[33m14:03:34,794 WARN  [org.jboss.as.server] (Controller Boot Thread) JBAS015883: No security realm defined for native management service; all access will be unrestricted.
[0m[0m14:03:34,799 INFO  [org.xnio] (MSC service thread 1-3) XNIO Version 3.0.7.GA
[0m[0m14:03:34,825 INFO  [org.xnio.nio] (MSC service thread 1-3) XNIO NIO Implementation Version 3.0.7.GA
[0m[0m14:03:34,862 INFO  [org.jboss.remoting] (MSC service thread 1-3) JBoss Remoting version 3.2.14.GA
[0m14:03:34,957 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 15) JBAS010280: Activating Infinispan subsystem.
14:03:34,963 INFO  [org.jboss.as.clustering.jgroups] (ServerService Thread Pool -- 16) JBAS010260: Activating JGroups subsystem.
14:03:35,021 INFO  [org.jboss.as.naming] (ServerService Thread Pool -- 19) JBAS011800: Activating Naming Subsystem
14:03:35,037 INFO  [org.jboss.as.security] (ServerService Thread Pool -- 22) JBAS013171: Activating Security Subsystem
14:03:35,145 INFO  [org.jboss.as.security] (MSC service thread 1-1) JBAS013170: Current PicketBox version=4.0.15.Final
14:03:35,208 INFO  [org.jboss.as.naming] (MSC service thread 1-3) JBAS011802: Starting Naming Service
14:03:35,219 INFO  [org.jboss.as.remoting] (MSC service thread 1-4) JBAS017100: Listening on 192.168.11.101:9999
14:03:35,220 INFO  [org.jboss.as.remoting] (MSC service thread 1-2) JBAS017100: Listening on 192.168.11.101:4447
14:03:35,231 INFO  [org.jboss.as.connector.logging] (MSC service thread 1-2) JBAS010408: Starting JCA Subsystem (JBoss IronJacamar 1.0.15.Final)
14:03:35,782 WARN  [org.jgroups.stack.Configurator] (MSC service thread 1-3) [JGRP00014] TP.enable_bundling has been deprecated: will be ignored as bundling is on by default
14:03:37,024 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-2) JDGS010000: HotRodServer starting
14:03:37,028 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-2) JDGS010001: HotRodServer listening on 192.168.11.101:11222
14:03:37,311 INFO  [org.infinispan.remoting.transport.jgroups.JGroupsTransport] (MSC service thread 1-3) ISPN000078: Starting JGroups Channel
14:03:37,326 WARN  [org.jgroups.protocols.UDP] (MSC service thread 1-3) [JGRP00015] the send buffer of socket DatagramSocket was set to 640KB, but the OS only allocated 180.22KB. This might lead to performance problems. Please set your max send buffer in the OS correctly (e.g. net.core.wmem_max on Linux)
14:03:37,327 WARN  [org.jgroups.protocols.UDP] (MSC service thread 1-3) [JGRP00015] the receive buffer of socket DatagramSocket was set to 20MB, but the OS only allocated 180.22KB. This might lead to performance problems. Please set your max receive buffer in the OS correctly (e.g. net.core.rmem_max on Linux)
14:03:37,327 WARN  [org.jgroups.protocols.UDP] (MSC service thread 1-3) [JGRP00015] the send buffer of socket MulticastSocket was set to 640KB, but the OS only allocated 180.22KB. This might lead to performance problems. Please set your max send buffer in the OS correctly (e.g. net.core.wmem_max on Linux)
14:03:37,328 WARN  [org.jgroups.protocols.UDP] (MSC service thread 1-3) [JGRP00015] the receive buffer of socket MulticastSocket was set to 25MB, but the OS only allocated 180.22KB. This might lead to performance problems. Please set your max receive buffer in the OS correctly (e.g. net.core.rmem_max on Linux)
14:03:37,331 INFO  [stdout] (MSC service thread 1-3) 
14:03:37,331 INFO  [stdout] (MSC service thread 1-3) -------------------------------------------------------------------
14:03:37,331 INFO  [stdout] (MSC service thread 1-3) GMS: address=node01/default, cluster=default, physical address=192.168.11.101:55200
14:03:37,331 INFO  [stdout] (MSC service thread 1-3) -------------------------------------------------------------------
14:03:40,972 INFO  [org.infinispan.remoting.transport.jgroups.JGroupsTransport] (MSC service thread 1-3) ISPN000094: Received new cluster view: [node02/default|1] [node02/default, node01/default]
14:03:41,135 INFO  [org.infinispan.remoting.transport.jgroups.JGroupsTransport] (MSC service thread 1-3) ISPN000079: Cache local address is node01/default, physical addresses are [192.168.11.101:55200]
14:03:41,139 INFO  [org.infinispan.factories.GlobalComponentRegistry] (MSC service thread 1-3) ISPN000128: Infinispan version: Infinispan 'Tactical Nuclear Penguin' 5.3.0-SNAPSHOT
14:03:41,310 INFO  [org.infinispan.jmx.CacheJmxRegistration] (MSC service thread 1-3) ISPN000031: MBeans were successfully registered to the platform MBean server.
14:03:41,503 INFO  [org.jboss.as.clustering.infinispan] (MSC service thread 1-3) JBAS010281: Started testCache cache from default container
14:03:41,647 INFO  [org.infinispan.jmx.CacheJmxRegistration] (MSC service thread 1-2) ISPN000031: MBeans were successfully registered to the platform MBean server.
14:03:41,702 INFO  [org.jboss.as.clustering.infinispan] (MSC service thread 1-2) JBAS010281: Started ___hotRodTopologyCache cache from default container
14:03:41,873 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015874: JBoss Infinispan Server 5.3.0-SNAPSHOT (AS 7.2.0.Final) started in 10819ms - Started 80 of 107 services (27 services are passive or on-demand)
{code}

> Logging produces strange beginning of lines
> -------------------------------------------
>
>                 Key: ISPN-3081
>                 URL: https://issues.jboss.org/browse/ISPN-3081
>             Project: Infinispan
>          Issue Type: Bug
>          Components: Server
>    Affects Versions: 5.3.0.Alpha1
>            Reporter: Michal Linhard
>            Assignee: Tristan Tarrant
>
> This is what I get on the console when running infinispan-server-5.3.0-SNAPSHOT
> {code}
> [0m06:38:12,718 INFO  [org.jboss.modules] (main) JBoss Modules version 1.2.0.CR1
> [0m[0m06:38:13,282 INFO  [org.jboss.msc] (main) JBoss MSC version 1.0.4.GA
> [0m[0m06:38:13,486 INFO  [org.jboss.as] (MSC service thread 1-7) JBAS015899: JBoss Infinispan Server 5.3.0-SNAPSHOT (AS 7.2.0.Final) starting
> [0m[31m06:38:14,687 ERROR [org.jboss.as.server] (Controller Boot Thread) JBAS015956: Caught exception during boot: org.jboss.as.controller.persistence.ConfigurationPersistenceException: JBAS014676: Failed to parse configuration
> ..
> {code}
> configuration:
> https://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/jdg-perf-cs-client-stress-test-infinispan53-snapshot-regression-auto/5/artifact/report/size4/configs.zip
> whole logs:
> https://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/jdg-perf-cs-client-stress-test-infinispan53-snapshot-regression-auto/5/artifact/report/size4/serverlogs.zip

--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira