Return-Path: X-Original-To: archive-asf-public-internal@cust-asf2.ponee.io Delivered-To: archive-asf-public-internal@cust-asf2.ponee.io Received: from cust-asf.ponee.io (cust-asf.ponee.io [163.172.22.183]) by cust-asf2.ponee.io (Postfix) with ESMTP id F1234200C3D for ; Tue, 14 Mar 2017 14:50:07 +0100 (CET) Received: by cust-asf.ponee.io (Postfix) id EF8CE160B7E; Tue, 14 Mar 2017 13:50:07 +0000 (UTC) Delivered-To: archive-asf-public@cust-asf.ponee.io Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by cust-asf.ponee.io (Postfix) with SMTP id EAB9A160B7C for ; Tue, 14 Mar 2017 14:50:06 +0100 (CET) Received: (qmail 88292 invoked by uid 500); 14 Mar 2017 13:50:04 -0000 Mailing-List: contact dev-help@activemq.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: dev@activemq.apache.org Delivered-To: mailing list dev@activemq.apache.org Received: (qmail 88265 invoked by uid 99); 14 Mar 2017 13:50:03 -0000 Received: from pnap-us-west-generic-nat.apache.org (HELO spamd3-us-west.apache.org) (209.188.14.142) by apache.org (qpsmtpd/0.29) with ESMTP; Tue, 14 Mar 2017 13:50:03 +0000 Received: from localhost (localhost [127.0.0.1]) by spamd3-us-west.apache.org (ASF Mail Server at spamd3-us-west.apache.org) with ESMTP id BFCA718063D for ; Tue, 14 Mar 2017 13:50:02 +0000 (UTC) X-Virus-Scanned: Debian amavisd-new at spamd3-us-west.apache.org X-Spam-Flag: NO X-Spam-Score: 0.68 X-Spam-Level: X-Spam-Status: No, score=0.68 tagged_above=-999 required=6.31 tests=[DKIM_SIGNED=0.1, DKIM_VALID=-0.1, DKIM_VALID_AU=-0.1, KAM_ASCII_DIVIDERS=0.8, RCVD_IN_DNSWL_NONE=-0.0001, RCVD_IN_MSPIKE_H3=-0.01, RCVD_IN_MSPIKE_WL=-0.01, SPF_PASS=-0.001, URIBL_BLOCKED=0.001] autolearn=disabled Authentication-Results: spamd3-us-west.apache.org (amavisd-new); dkim=pass (2048-bit key) header.d=gmail.com Received: from mx1-lw-us.apache.org ([10.40.0.8]) by localhost (spamd3-us-west.apache.org [10.40.0.10]) (amavisd-new, port 10024) with ESMTP id 1fDKKecj-yUT for ; Tue, 14 Mar 2017 13:50:00 +0000 (UTC) Received: from mail-wm0-f44.google.com (mail-wm0-f44.google.com [74.125.82.44]) by mx1-lw-us.apache.org (ASF Mail Server at mx1-lw-us.apache.org) with ESMTPS id 873455FAF3 for ; Tue, 14 Mar 2017 13:49:59 +0000 (UTC) Received: by mail-wm0-f44.google.com with SMTP id n11so64439544wma.1 for ; Tue, 14 Mar 2017 06:49:59 -0700 (PDT) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=gmail.com; s=20161025; h=mime-version:in-reply-to:references:from:date:message-id:subject:to; bh=s3Ao9Rc41b11J4i79V+UwmssnQE/x8ouXPusp1sQ52k=; b=JX38deps34Tdjbstf4hxxcVIASvCINDB/xm5GdPcpI7/CePNn6jY9QrIaKkPTuVcS4 2hoYCkrXEirnKASRm6/kbCQs6Hq18oG68XTgb+CerW+caO93jG37qUSzHo7RhVU2F5tS hhdBI1EbQWm/P9behNxUgcA4pya4eedp6rCg5ZF3s+9VlB0YW2UUHvqRvZvv3BMBP+3z PwYHkwtVE8AxAzdzIHdzFCfv9gVpAG2rvcMNMy3VhrrhFN/OSDfvSUJ7LfgO8wx4RSVw 8fdUYKNkCyzEcMzQcSxr6NgcbBqtVNmK/QRI5Rnz3QCz6XcdRovxiAtplsJnCMzDaFGW gbWw== X-Google-DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=1e100.net; s=20161025; h=x-gm-message-state:mime-version:in-reply-to:references:from:date :message-id:subject:to; bh=s3Ao9Rc41b11J4i79V+UwmssnQE/x8ouXPusp1sQ52k=; b=mJz5JQpxg5h5J4iwkFe2IGsrNy8D90NbCGGGJ9XaO5ovW6BTx4Y5h9RpeGY2TKNVCL 5jGUTILGMmBX9Tg9f5oKowXF/VDNvZ/R19kaVI3ydvhYGGlPCp0z9FxxcKM9OCmSXXvP c5NAYgbslZ38+0fXN/qEbV8KEL3O2Kw6h2leeQlc2RP0EovV1HE/4rUZYi7z2I38NXhk m6M9y75pRmfEyqwb/2sIe9ikpn8yAWQV3Fq64QqS3R9cqc+fFGaqidNHV87UXM7bFpSG l/B6aB09cUmx6M/78y4oTrEi2+t+AMDPiZSHOgltEoDxRJTVqw7pkzyMyl6dW8TwMuJi 88Ag== X-Gm-Message-State: AFeK/H0Hrv+aHmjboc8fjulOFYYkxsXxcr92xh1O+mE+6JmjvdL1k0wsT+s0a4l8IxIb2sCTjng2m9Gh2qGZQg== X-Received: by 10.28.51.140 with SMTP id z134mr15614633wmz.55.1489499398323; Tue, 14 Mar 2017 06:49:58 -0700 (PDT) MIME-Version: 1.0 Received: by 10.223.179.80 with HTTP; Tue, 14 Mar 2017 06:49:57 -0700 (PDT) In-Reply-To: References: <1596073289.1451002.1489419326308.JavaMail.zimbra@redhat.com> From: Clebert Suconic Date: Tue, 14 Mar 2017 09:49:57 -0400 Message-ID: Subject: Re: Artemis 1.5.2 - AMQ224000: Failure in initialisation: java.lang.NullPointerException To: "dev@activemq.apache.org" Content-Type: text/plain; charset=UTF-8 archived-at: Tue, 14 Mar 2017 13:50:08 -0000 Same deal as during your restart... an update without an append (add) during compactation... this case was ignored though... I'm changing master to add a stack trace in case it happens again (so we can know for sure where it happened).. but I don't foresee any issues beyond the warning. On Mon, Mar 13, 2017 at 5:20 PM, Mohamed Badri wrote: > It works, after building packages from 1.x branch ( 1.6.0-SNAPSHOT ) > I was able to recover the 50K missing messages. > > Thanks a lot for that. > > On the same instance I had an NPE without stack trace. > Can someone explain me what happens, or what can be the cause > of the following messages logs : > > > *05:31:08,129 WARN [org.apache.activemq.artemis.journal] AMQ142007: Can > not find record 59,006,361 during compact replay* > > *05:31:08,129 WARN [org.apache.activemq.artemis.journal] AMQ142007: Can > not find record 59,006,351 during compact replay* > > *05:31:08,129 WARN [org.apache.activemq.artemis.journal] AMQ142007: Can > not find record 59,006,377 during compact replay* > > *05:31:08,130 WARN [org.apache.activemq.artemis.journal] AMQ142007: Can > not find record 59,006,353 during compact replay* > > *05:31:08,130 WARN [org.apache.activemq.artemis.journal] AMQ142007: Can > not find record 59,006,379 during compact replay* > > *05:31:08,130 WARN [org.apache.activemq.artemis.journal] AMQ142012: > Couldnt find tx={0} to merge after compacting* > > *05:31:08,130 WARN [org.apache.activemq.artemis.journal] AMQ142012: > Couldnt find tx={0} to merge after compacting* > > *05:59:58,796 WARN [org.apache.activemq.artemis.journal] AMQ142028: Error > replaying pending commands after compacting: java.lang.NullPointerException* > > *05:59:58,798 WARN [org.apache.activemq.artemis.journal] AMQ142028: Error > replaying pending commands after compacting: java.lang.NullPointerException* > > > Thanks in advance. > > On 13 March 2017 at 15:35, Justin Bertram wrote: > >> Should be merged now on master and 1.x branches. >> >> >> Justin >> >> ----- Original Message ----- >> From: "Clebert Suconic" >> To: dev@activemq.apache.org >> Sent: Monday, March 13, 2017 10:25:40 AM >> Subject: Re: Artemis 1.5.2 - AMQ224000: Failure in initialisation: >> java.lang.NullPointerException >> >> It hasn't been merged yet... give me some time. >> >> On Mon, Mar 13, 2017 at 11:02 AM, Mohamed Badri >> wrote: >> > Thanks a lot, >> > I'll apply this patch on the 1.5.4 release. >> > >> > >> > >> > On 13 March 2017 at 13:09, Clebert Suconic >> > wrote: >> > >> >> You will have to patch the server to be able to restart that server: >> >> >> >> https://github.com/apache/activemq-artemis/pull/1089 >> >> >> >> >> >> >> >> >> >> On Mon, Mar 13, 2017 at 5:42 AM, Mohamed Badri >> wrote: >> >> > Hi, >> >> > >> >> > I'm using Artemis 1.5.2 >> >> > and after a problem due to load on the artemis server >> >> > I had to restart one instance. >> >> > >> >> > Then, when the instance with the following errors : >> >> > >> >> > ======================================================= >> >> > >> >> > 07:35:12,021 WARN [org.apache.activemq.artemis.journal] AMQ142015: >> >> > Uncommitted transaction with id 702,425,640 found and discarded >> >> > >> >> > 07:35:12,021 WARN [org.apache.activemq.artemis.journal] AMQ142015: >> >> > Uncommitted transaction with id 702,425,688 found and discarded >> >> > >> >> > 07:35:12,021 WARN [org.apache.activemq.artemis.journal] AMQ142015: >> >> > Uncommitted transaction with id 702,425,713 found and discarded >> >> > >> >> > 07:35:12,021 WARN [org.apache.activemq.artemis.journal] AMQ142015: >> >> > Uncommitted transaction with id 787,568,230 found and discarded >> >> > >> >> > 07:35:12,022 WARN [org.apache.activemq.artemis.journal] AMQ142015: >> >> > Uncommitted transaction with id 787,568,362 found and discarded >> >> > >> >> > 07:35:12,022 WARN [org.apache.activemq.artemis.journal] AMQ142015: >> >> > Uncommitted transaction with id 787,568,543 found and discarded >> >> > >> >> > 07:35:12,311 ERROR [org.apache.activemq.artemis.core.server] >> AMQ224000: >> >> > Failure in initialisation: java.lang.NullPointerException >> >> > >> >> > at >> >> > org.apache.activemq.artemis.core.persistence.impl.journal. >> >> AbstractJournalStorageManager.loadMessageJournal( >> >> AbstractJournalStorageManager.java:969) >> >> > [artemis-server-1.5.2.jar:1.5.2] >> >> > >> >> > at >> >> > org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl. >> >> loadJournals(ActiveMQServerImpl.java:2213) >> >> > [artemis-server-1.5.2.jar:1.5.2] >> >> > >> >> > at >> >> > org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl. >> >> initialisePart2(ActiveMQServerImpl.java:2067) >> >> > [artemis-server-1.5.2.jar:1.5.2] >> >> > >> >> > at >> >> > org.apache.activemq.artemis.core.server.impl. >> >> SharedNothingLiveActivation.run(SharedNothingLiveActivation.java:104) >> >> > [artemis-server-1.5.2.jar:1.5.2] >> >> > >> >> > at >> >> > org.apache.activemq.artemis.core.server.impl.ActiveMQServerImpl. >> >> internalStart(ActiveMQServerImpl.java:520) >> >> > [artemis-server-1.5.2.jar:1.5.2] >> >> > >> >> > at >> >> > org.apache.activemq.artemis.core.server.impl. >> ActiveMQServerImpl.start( >> >> ActiveMQServerImpl.java:469) >> >> > [artemis-server-1.5.2.jar:1.5.2] >> >> > >> >> > at >> >> > org.apache.activemq.artemis.jms.server.impl. >> JMSServerManagerImpl.start( >> >> JMSServerManagerImpl.java:412) >> >> > [artemis-jms-server-1.5.2.jar:1.5.2] >> >> > >> >> > at >> >> > org.apache.activemq.artemis.integration.FileBroker.start( >> >> FileBroker.java:66) >> >> > [artemis-cli-1.5.2.jar:1.5.2] >> >> > >> >> > at >> >> > org.apache.activemq.artemis.cli.commands.Run.execute(Run.java:78) >> >> > [artemis-cli-1.5.2.jar:1.5.2] >> >> > >> >> > at >> >> > org.apache.activemq.artemis.cli.Artemis.internalExecute( >> >> Artemis.java:124) >> >> > [artemis-cli-1.5.2.jar:1.5.2] >> >> > >> >> > at org.apache.activemq.artemis.cli.Artemis.execute(Artemis. >> >> java:81) >> >> > [artemis-cli-1.5.2.jar:1.5.2] >> >> > >> >> > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native >> Method) >> >> > [rt.jar:1.8.0_66] >> >> > >> >> > at >> >> > sun.reflect.NativeMethodAccessorImpl.invoke( >> >> NativeMethodAccessorImpl.java:62) >> >> > [rt.jar:1.8.0_66] >> >> > >> >> > at >> >> > sun.reflect.DelegatingMethodAccessorImpl.invoke( >> >> DelegatingMethodAccessorImpl.java:43) >> >> > [rt.jar:1.8.0_66] >> >> > >> >> > at java.lang.reflect.Method.invoke(Method.java:497) >> >> > [rt.jar:1.8.0_66] >> >> > >> >> > at >> >> > org.apache.activemq.artemis.boot.Artemis.execute(Artemis.java:129) >> >> > [artemis-boot.jar:1.5.2] >> >> > >> >> > at org.apache.activemq.artemis.boot.Artemis.main(Artemis. >> >> java:49) >> >> > [artemis-boot.jar:1.5.2] >> >> > ======================================================= >> >> > >> >> > After that the instance stops and I can't recover the queues and >> messages >> >> > persisted before I stopped the instance. >> >> > >> >> > This instance is master in a replication setup, >> >> > when this problem happened the slave was stopped. >> >> > >> >> > Any Information on this problem ? >> >> > Thanks in advance. >> >> >> >> >> >> >> >> -- >> >> Clebert Suconic >> >> >> >> >> >> -- >> Clebert Suconic >> -- Clebert Suconic