From owner-freebsd-ports@freebsd.org  Fri May  6 13:29:30 2016
Return-Path: <owner-freebsd-ports@freebsd.org>
Delivered-To: freebsd-ports@mailman.ysv.freebsd.org
Received: from mx1.freebsd.org (mx1.freebsd.org
 [IPv6:2001:1900:2254:206a::19:1])
 by mailman.ysv.freebsd.org (Postfix) with ESMTP id 9B8E4B2FF88
 for <freebsd-ports@mailman.ysv.freebsd.org>;
 Fri,  6 May 2016 13:29:30 +0000 (UTC)
 (envelope-from guru@unixarea.de)
Received: from ms-10.1blu.de (ms-10.1blu.de [178.254.4.101])
 (using TLSv1 with cipher AES256-SHA (256/256 bits))
 (Client did not present a certificate)
 by mx1.freebsd.org (Postfix) with ESMTPS id 6012E1F9B
 for <freebsd-ports@freebsd.org>; Fri,  6 May 2016 13:29:30 +0000 (UTC)
 (envelope-from guru@unixarea.de)
Received: from [88.217.109.142] (helo=localhost.unixarea.de)
 by ms-10.1blu.de with esmtpsa (TLS1.0:DHE_RSA_AES_256_CBC_SHA1:32)
 (Exim 4.76) (envelope-from <guru@unixarea.de>) id 1ayfor-0005Kq-Cf
 for freebsd-ports@freebsd.org; Fri, 06 May 2016 15:29:25 +0200
Received: from localhost.my.domain (c720-r292778-amd64 [127.0.0.1])
 by localhost.unixarea.de (8.15.2/8.14.9) with ESMTPS id u46DTNYJ002429
 (version=TLSv1.2 cipher=DHE-RSA-AES256-GCM-SHA384 bits=256 verify=NO)
 for <freebsd-ports@freebsd.org>; Fri, 6 May 2016 15:29:24 +0200 (CEST)
 (envelope-from guru@unixarea.de)
Received: (from guru@localhost)
 by localhost.my.domain (8.15.2/8.14.9/Submit) id u46DTNnR002428
 for freebsd-ports@freebsd.org; Fri, 6 May 2016 15:29:23 +0200 (CEST)
 (envelope-from guru@unixarea.de)
X-Authentication-Warning: localhost.my.domain: guru set sender to
 guru@unixarea.de using -f
Date: Fri, 6 May 2016 15:29:22 +0200
From: Matthias Apitz <guru@unixarea.de>
To: freebsd-ports@freebsd.org
Subject: Re: Poudriere Timeout
Message-ID: <20160506132922.GA2394@c720-r292778-amd64.oa.oclc.org>
Reply-To: Matthias Apitz <guru@unixarea.de>
Mail-Followup-To: Matthias Apitz <guru@unixarea.de>, freebsd-ports@freebsd.org
References: <201501190145.t0J1jKvg006268@slippy.cwsent.com>
 <20150119051751.GA1185@c720-r276659>
 <20160506092114.GA2119@c720-r292778-amd64>
MIME-Version: 1.0
Content-Type: text/plain; charset=utf-8
Content-Disposition: inline
Content-Transfer-Encoding: quoted-printable
In-Reply-To: <20160506092114.GA2119@c720-r292778-amd64>
X-Operating-System: FreeBSD 11.0-CURRENT r292778 (amd64)
User-Agent: Mutt/1.5.24 (2015-08-30)
X-Con-Id: 51246
X-Con-U: 0-guru
X-Originating-IP: 88.217.109.142
X-BeenThere: freebsd-ports@freebsd.org
X-Mailman-Version: 2.1.22
Precedence: list
List-Id: Porting software to FreeBSD <freebsd-ports.freebsd.org>
List-Unsubscribe: <https://lists.freebsd.org/mailman/options/freebsd-ports>,
 <mailto:freebsd-ports-request@freebsd.org?subject=unsubscribe>
List-Archive: <http://lists.freebsd.org/pipermail/freebsd-ports/>
List-Post: <mailto:freebsd-ports@freebsd.org>
List-Help: <mailto:freebsd-ports-request@freebsd.org?subject=help>
List-Subscribe: <https://lists.freebsd.org/mailman/listinfo/freebsd-ports>,
 <mailto:freebsd-ports-request@freebsd.org?subject=subscribe>
X-List-Received-Date: Fri, 06 May 2016 13:29:30 -0000

El d=C3=ADa Friday, May 06, 2016 a las 11:21:14AM +0200, Matthias Apitz esc=
ribi=C3=B3:

>=20
> Last night one of my thousand ports build with poudriere was hit exactly
> at the same port and point:
>=20
>=20
> ...
> =3D=3D=3D=3D> Compressing man pages (compress-man)
> =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D
> =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D<pha=
se: package        >=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D
> =3D=3D=3D>  Building package for texlive-texmf-20150523_3
> =3D=3D=3D=3D>> Killing timed out build after 3600 seconds
> =3D=3D=3D=3D>> Cleaning up wrkdir
> ...
>=20
>=20
> This let me think that there must be something special (read 'bug')
> either in the port itself or in poudriere.
>=20
> Is it worth to file an issue in our bug tracker?

I have here a log of the poudriere job (run as single builder) with
timestamps:


14:50:40: =3D=3D=3D> Creating users
14:50:40: Creating user 'avahi' with uid '558'.
14:50:40: [freebsd-r292778-ports-20160501-job-01] | | `-- Extracting avahi-=
app-0.6.31_5: .......... done
14:50:40: [freebsd-r292778-ports-20160501-job-01] | | `-- Installing gnutls=
-3.4.11...
14:50:40: ...

14:50:49: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D<phase: configure >=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D
14:50:49: =3D=3D=3D> Configuring for texlive-texmf-20150523_3
14:50:49: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D
14:50:49: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D<phase: build >=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D
14:50:49: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D
14:50:49: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D<phase: run-depends >=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D
14:50:49: =3D=3D=3D> texlive-texmf-20150523_3 depends on file: /usr/local/s=
hare/texmf-dist/.texlive-tlmgr - found
14:50:49: =3D=3D=3D> texlive-texmf-20150523_3 depends on package: texlive-b=
ase>=3D20150521_5 - found
14:50:49: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D
14:50:49: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D<phase: stage >=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D
14:50:49: =3D=3D=3D> Staging for texlive-texmf-20150523_3
14:50:49: =3D=3D=3D> Generating temporary packing list
14:50:50: ...

14:54:23: /usr/bin/touch /wrkdirs/usr/ports/print/texlive-texmf/work/stage/=
usr/local/share/texmf-dist/source/.keep_me
14:54:23: =3D=3D=3D=3D> Compressing man pages (compress-man)
14:54:23: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D
14:54:23: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D<phase: package >=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D
14:54:24: =3D=3D=3D> Building package for texlive-texmf-20150523_3
15:10:01: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=
=3D=3D=3D=3D
15:10:01: =3D=3D=3D=3D>> Cleaning up wrkdir
15:10:03: =3D=3D=3D> Cleaning for texlive-texmf-20150523_3
15:10:17: =1B[1;33m=3D=3D=3D=3D>>=1B[0;0m =1B[1;33mWarning: Leftover proces=
ses:
15:10:17: =1B[0;0mUSER PID %CPU %MEM VSZ RSS TT STAT STARTED TIME COMMAND
15:10:17: build of print/texlive-texmf ended at Fri May 6 15:10:17 CEST 2016
15:10:17: build time: 00:22:37

The package build time was only around 15 minutes.

Btw: would be nice if the log would have such timestamps as default;

	matthias

--=20
Matthias Apitz, =E2=9C=89 guru@unixarea.de, =E2=8C=82 http://www.unixarea.d=
e/  =E2=98=8E +49-176-38902045
=C2=A1Dios querido denos otra vez los problemas de ayer, los que tuvimos en=
 la RDA!
My Lord, give us back the problems of yesterday, those we have had in the G=
DR.