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 4DC8A200B6F for ; Wed, 24 Aug 2016 10:18:29 +0200 (CEST) Received: by cust-asf.ponee.io (Postfix) id 4C42B160AB1; Wed, 24 Aug 2016 08:18:29 +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 938AD160AA4 for ; Wed, 24 Aug 2016 10:18:28 +0200 (CEST) Received: (qmail 22416 invoked by uid 500); 24 Aug 2016 08:18:27 -0000 Mailing-List: contact dev-help@httpd.apache.org; run by ezmlm Precedence: bulk Reply-To: dev@httpd.apache.org list-help: list-unsubscribe: List-Post: List-Id: Delivered-To: mailing list dev@httpd.apache.org Received: (qmail 22406 invoked by uid 99); 24 Aug 2016 08:18:27 -0000 Received: from pnap-us-west-generic-nat.apache.org (HELO spamd4-us-west.apache.org) (209.188.14.142) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 24 Aug 2016 08:18:27 +0000 Received: from localhost (localhost [127.0.0.1]) by spamd4-us-west.apache.org (ASF Mail Server at spamd4-us-west.apache.org) with ESMTP id 316C9C09C3 for ; Wed, 24 Aug 2016 08:18:27 +0000 (UTC) X-Virus-Scanned: Debian amavisd-new at spamd4-us-west.apache.org X-Spam-Flag: NO X-Spam-Score: 1 X-Spam-Level: * X-Spam-Status: No, score=1 tagged_above=-999 required=6.31 tests=[KAM_LAZY_DOMAIN_SECURITY=1] autolearn=disabled Received: from mx1-lw-us.apache.org ([10.40.0.8]) by localhost (spamd4-us-west.apache.org [10.40.0.11]) (amavisd-new, port 10024) with ESMTP id 5WvksgHbVWLV for ; Wed, 24 Aug 2016 08:18:23 +0000 (UTC) Received: from cloud1-vm154.de-nserver.de (cloud1-vm154.de-nserver.de [178.250.10.56]) by mx1-lw-us.apache.org (ASF Mail Server at mx1-lw-us.apache.org) with ESMTPS id 3FE105FB57 for ; Wed, 24 Aug 2016 08:18:22 +0000 (UTC) Received: (qmail 6062 invoked from network); 24 Aug 2016 10:18:16 +0200 X-Fcrdns: No Received: from phoffice.de-nserver.de (HELO [10.11.11.93]) (185.39.223.5) (smtp-auth username hostmaster@profihost.com, mechanism plain) by cloud1-vm154.de-nserver.de (qpsmtpd/0.92) with (ECDHE-RSA-AES256-SHA encrypted) ESMTPSA; Wed, 24 Aug 2016 10:18:16 +0200 Subject: Re: mod_http2 - h2_session(): connections get's closed on graceful restart To: dev@httpd.apache.org References: <57B99DF9.60004@profihost.ag> <47944231-A1D3-4691-9894-6E78694377FC@greenbytes.de> Cc: Stefan Eissing From: Stefan Priebe - Profihost AG Message-ID: <1e3ff06a-7d3b-14e8-be7c-3633ca6b5c72@profihost.ag> Date: Wed, 24 Aug 2016 10:18:15 +0200 User-Agent: Mozilla/5.0 (X11; Linux x86_64; rv:45.0) Gecko/20100101 Thunderbird/45.2.0 MIME-Version: 1.0 In-Reply-To: <47944231-A1D3-4691-9894-6E78694377FC@greenbytes.de> Content-Type: text/plain; charset=windows-1252 Content-Transfer-Encoding: 7bit X-User-Auth: Auth by hostmaster@profihost.com through 185.39.223.5 archived-at: Wed, 24 Aug 2016 08:18:29 -0000 Hi Stefan, were you able to reproduce? Did you need any help? Greets, Stefan Am 22.08.2016 um 18:07 schrieb Stefan Eissing: > Hi Stefan, > > I am looking into this. It is definitely a bug in mod_http2. > >> Am 21.08.2016 um 14:26 schrieb Stefan Priebe : >> >> Hi, >> >> i'm running apache 2.4.23 with nghttpd 1.13 and i'm wondoring if it is correct that chrome says: >> ERR_CONNECTION_CLOSED >> >> while loading a page when the webserver does a graceful reload. This does not happen with http 1/1 and mod_ssl. >> >> The log is below. >> >> Thanks, >> Stefan >> >> >> [Sun Aug 21 14:15:43.779555 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(1703): [client X.X.X.X:53763] AH03078: h2_session(0): transit [WAIT] -- wait cycle --> [BUSY] >> [Sun Aug 21 14:15:43.779619 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(1703): [client X.X.X.X:53763] AH03078: h2_session(0): transit [BUSY] -- no io --> [WAIT] >> [Sun Aug 21 14:15:43.979704 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(1703): [client X.X.X.X:53763] AH03078: h2_session(0): transit [WAIT] -- wait cycle --> [BUSY] >> [Sun Aug 21 14:15:43.979757 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(1703): [client X.X.X.X:53763] AH03078: h2_session(0): transit [BUSY] -- no io --> [WAIT] >> [Sun Aug 21 14:15:44.179865 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(1703): [client X.X.X.X:53763] AH03078: h2_session(0): transit [WAIT] -- wait cycle --> [BUSY] >> [Sun Aug 21 14:15:44.179922 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(1703): [client X.X.X.X:53763] AH03078: h2_session(0): transit [BUSY] -- no io --> [WAIT] >> [Sun Aug 21 14:15:44.380030 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(1703): [client X.X.X.X:53763] AH03078: h2_session(0): transit [WAIT] -- wait cycle --> [BUSY] >> [Sun Aug 21 14:15:44.380080 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(1703): [client X.X.X.X:53763] AH03078: h2_session(0): transit [BUSY] -- no io --> [WAIT] >> [Sun Aug 21 14:15:44.486387 2016] [mpm_event:notice] [pid 29610:tid 140311984822144] AH00493: SIGUSR1 received. Doing graceful restart >> [Sun Aug 21 14:15:44.580194 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(1703): [client X.X.X.X:53763] AH03078: h2_session(0): transit [WAIT] -- wait cycle --> [BUSY] >> [Sun Aug 21 14:15:44.580242 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(655): [client X.X.X.X:53763] AH03068: h2_session(0): sent FRAME[GOAWAY[error=0, reason='', last_stream=1]], frames=4/3 (r/s) >> [Sun Aug 21 14:15:44.580296 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(752): [client X.X.X.X:53763] AH03069: session(0): sent GOAWAY, err=0, msg= >> [Sun Aug 21 14:15:44.580301 2016] [http2:debug] [pid 29625:tid 140311678985984] h2_session.c(1703): [client X.X.X.X:53763] AH03078: h2_session(0): transit [BUSY] -- local goaway --> [LSHUTDOWN] >> [Sun Aug 21 14:15:44.580333 2016] [ssl:debug] [pid 29625:tid 140311678985984] ssl_engine_io.c(1033): [client X.X.X.X:53763] AH02001: Connection closed to child 0 with standard shutdown (server XYZ:443) >> [Sun Aug 21 14:15:47.495352 2016] [ldap:debug] [pid 29610:tid 140311984822144] util_ldap.c(2533): AH01307: LDAP: SSL trusted mode - SSL >> [Sun Aug 21 14:15:47.495871 2016] [ldap:debug] [pid 29610:tid 140311984822144] util_ldap.c(2569): AH01308: LDAP: SSL verify server certificate - FALSE >> [Sun Aug 21 14:15:47.544226 2016] [auth_digest:notice] [pid 29610:tid 140311984822144] AH01757: generating secret for digest authentication ... >> ... >> >