Skip site navigation (1)Skip section navigation (2)
Date:      Tue, 12 May 2009 10:17:51 -0500
From:      Robert Noland <rnoland@FreeBSD.org>
To:        David Johnson <david@usermode.org>
Cc:        freebsd-stable@freebsd.org
Subject:   Re: Xorg hangs with drmwtq in 7.2-RELEASE
Message-ID:  <1242141471.1755.11.camel@balrog.2hip.net>
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>

next in thread | previous in thread | raw e-mail | index | archive | help

--=-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 <rnoland@FreeBSD.org>
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--




Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?1242141471.1755.11.camel>