From owner-freebsd-stable@FreeBSD.ORG Tue May 12 15:18:24 2009 Return-Path: Delivered-To: freebsd-stable@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 69173106566B for ; Tue, 12 May 2009 15:18:24 +0000 (UTC) (envelope-from rnoland@FreeBSD.org) Received: from gizmo.2hip.net (gizmo.2hip.net [64.74.207.195]) by mx1.freebsd.org (Postfix) with ESMTP id 39A188FC12 for ; Tue, 12 May 2009 15:18:24 +0000 (UTC) (envelope-from rnoland@FreeBSD.org) Received: from [192.168.1.4] (adsl-19-244-249.bna.bellsouth.net [68.19.244.249]) (authenticated bits=0) by gizmo.2hip.net (8.14.3/8.14.3) with ESMTP id n4CFIIwX025781 (version=TLSv1/SSLv3 cipher=DHE-RSA-AES256-SHA bits=256 verify=NO); Tue, 12 May 2009 11:18:19 -0400 (EDT) (envelope-from rnoland@FreeBSD.org) From: Robert Noland To: David Johnson In-Reply-To: <200905091841.26274.david@usermode.org> References: <200905042015.29394.david@usermode.org> <200905081458.53651.david@usermode.org> <1241821864.1733.51.camel@balrog.2hip.net> <200905091841.26274.david@usermode.org> Content-Type: multipart/signed; micalg="pgp-sha1"; protocol="application/pgp-signature"; boundary="=-6z9lvAbgfNdiPT5GLBTo" Organization: FreeBSD Date: Tue, 12 May 2009 10:17:51 -0500 Message-Id: <1242141471.1755.11.camel@balrog.2hip.net> Mime-Version: 1.0 X-Mailer: Evolution 2.26.1.1 FreeBSD GNOME Team Port X-Spam-Status: No, score=-3.2 required=5.0 tests=AWL,BAYES_00,RDNS_DYNAMIC autolearn=no version=3.2.5 X-Spam-Checker-Version: SpamAssassin 3.2.5 (2008-06-10) on gizmo.2hip.net Cc: freebsd-stable@freebsd.org Subject: Re: Xorg hangs with drmwtq in 7.2-RELEASE X-BeenThere: freebsd-stable@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Production branch of FreeBSD source code List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Tue, 12 May 2009 15:18:24 -0000 --=-6z9lvAbgfNdiPT5GLBTo Content-Type: text/plain Content-Transfer-Encoding: quoted-printable On Sat, 2009-05-09 at 18:41 -0700, David Johnson wrote: > On Friday 08 May 2009 03:31:04 pm Robert Noland wrote: > > In order to guess what might be causing this, drm debugging needs to be > > enabled before the hang, so that we can hopefully figure out what leads > > up to the hung GPU. >=20 > I'm not able to do that, but I did manage to get debug turned on and dmes= g > captured early enough to catch some additional information. I've place th= e > full file online at http://www.usermode.org/misc/dmesg.txt, but am includ= ing > some snippets here. Hopefully this is enough to move forward. >=20 > --=20 > David Johnson This trace still looks odd... > ... > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0xc0286429, nr=3D0x29, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:radeon_freelist_get] done_age =3D 102778 Things appear to be working at this point. > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0xc010644d, nr=3D0x4d, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:radeon_cp_indirect] idx=3D27 s=3D0 e=3D88 d=3D1 > [drm:pid1822:radeon_cp_dispatch_indirect] buf=3D27 s=3D0x0 e=3D0x58 Now, open count is 2 and something is calling close. > [drm:pid1822:drm_close] open_count =3D 2 > [drm:pid1822:drm_close] pid =3D 1822, device =3D 0xc615fa00, open_count = =3D 2 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0x80086442, nr=3D0x42, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:radeon_cp_stop]=20 > [drm:pid1822:radeon_do_cp_flush]=20 > [drm:pid1822:radeon_do_cp_idle]=20 > [drm:pid1822:radeon_do_cp_stop]=20 > [drm:pid1822:radeon_do_engine_reset]=20 > info: [drm] Num pipes: 1 > [drm:pid1822:radeon_do_cp_reset]=20 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0x800c6459, nr=3D0x59, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0x80086414, nr=3D0x14, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:drm_irq_uninstall] irq=3D16 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0x80546440, nr=3D0x40, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:radeon_do_cleanup_cp]=20 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0x80086439, nr=3D0x39, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:drm_sg_free] sg free virtual =3D 0xe8a64000 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0x8004667e, nr=3D0x7e, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0x8004667d, nr=3D0x7d, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0xc0086421, nr=3D0x21, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:drm_rmctx] 2 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0xc0086421, nr=3D0x21, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:drm_rmctx] 1 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0xc0086426, nr=3D0x26, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0xc0086426, nr=3D0x26, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:drm_ioctl] pid=3D1822, cmd=3D0x8008642b, nr=3D0x2b, dev 0xc6= 15fa00, auth=3D1 > [drm:pid1822:drm_unlock] 1 (pid 1822) requests unlock (0x80000001), flags= =3D 0x00000000 Another close, followed by lastclose, so drm is fully shutdown. > [drm:pid1822:drm_close] open_count =3D 1 > [drm:pid1822:drm_close] pid =3D 1822, device =3D 0xc615fa00, open_count = =3D 1 > [drm:pid1822:drm_lastclose]=20 > [drm:pid1822:radeon_do_cleanup_cp]=20 Now, this looks like several vt switches... We don't see the open sequence here, so I assume that debugging was disabled at this point. > info: [drm] Setting GART location based on new memory map > info: [drm] Loading R500 Microcode > info: [drm] Num pipes: 1 > info: [drm] writeback test succeeded in 1 usecs > drm0: [ITHREAD] > info: [drm] Num pipes: 1 > info: [drm] Setting GART location based on new memory map > info: [drm] Loading R500 Microcode > info: [drm] Num pipes: 1 > info: [drm] writeback test succeeded in 1 usecs > drm0: [ITHREAD] > info: [drm] Num pipes: 1 > info: [drm] Setting GART location based on new memory map > info: [drm] Loading R500 Microcode > info: [drm] Num pipes: 1 > info: [drm] writeback test succeeded in 1 usecs > drm0: [ITHREAD] > info: [drm] Num pipes: 1 > info: [drm] Setting GART location based on new memory map > info: [drm] Loading R500 Microcode > info: [drm] Num pipes: 1 > info: [drm] writeback test succeeded in 1 usecs > drm0: [ITHREAD] > info: [drm] Num pipes: 1 > info: [drm] Setting GART location based on new memory map > info: [drm] Loading R500 Microcode > info: [drm] Num pipes: 1 > info: [drm] writeback test succeeded in 1 usecs > drm0: [ITHREAD] > info: [drm] Num pipes: 1 > info: [drm] Setting GART location based on new memory map > info: [drm] Loading R500 Microcode > info: [drm] Num pipes: 1 > info: [drm] writeback test succeeded in 1 usecs > drm0: [ITHREAD] > info: [drm] Num pipes: 1 > info: [drm] Setting GART location based on new memory map > info: [drm] Loading R500 Microcode > info: [drm] Num pipes: 1 > info: [drm] writeback test succeeded in 1 usecs > drm0: [ITHREAD] and here debugging was re-enabled after the problem has occurred. > [drm:pid6216:drm_ioctl] returning 4 > [drm:pid6216:drm_ioctl] pid=3D6216, cmd=3D0x80046457, nr=3D0x57, dev 0xc6= 15fa00, auth=3D1 > [drm:pid6216:drm_ioctl] returning 4 > [drm:pid6216:drm_ioctl] pid=3D6216, cmd=3D0x80046457, nr=3D0x57, dev 0xc6= 15fa00, auth=3D1 > [drm:pid6216:drm_ioctl] returning 4 > [drm:pid6216:drm_ioctl] pid=3D6216, cmd=3D0x80046457, nr=3D0x57, dev 0xc6= 15fa00, auth=3D1 > [drm:pid6216:drm_ioctl] returning 4 robert. > _______________________________________________ > freebsd-stable@freebsd.org mailing list > http://lists.freebsd.org/mailman/listinfo/freebsd-stable > To unsubscribe, send any mail to "freebsd-stable-unsubscribe@freebsd.org" --=20 Robert Noland FreeBSD --=-6z9lvAbgfNdiPT5GLBTo Content-Type: application/pgp-signature; name="signature.asc" Content-Description: This is a digitally signed message part -----BEGIN PGP SIGNATURE----- Version: GnuPG v2.0.11 (FreeBSD) iEYEABECAAYFAkoJkx8ACgkQM4TrQ4qfRONigACeOD1lijq1WRN8PGkOVd2+SGEt Hd4AnAk0KnLjTJeNbBSxMZWIbwueUyAs =HUq7 -----END PGP SIGNATURE----- --=-6z9lvAbgfNdiPT5GLBTo--