From owner-freebsd-arm@freebsd.org Thu May 31 15:53:16 2018 Return-Path: Delivered-To: freebsd-arm@mailman.ysv.freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2610:1c1:1:606c::19:1]) by mailman.ysv.freebsd.org (Postfix) with ESMTP id CEF9CEFB96A for ; Thu, 31 May 2018 15:53:15 +0000 (UTC) (envelope-from ronald-lists@klop.ws) Received: from smarthost1.greenhost.nl (smarthost1.greenhost.nl [195.190.28.92]) (using TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 (128/128 bits)) (Client did not present a certificate) by mx1.freebsd.org (Postfix) with ESMTPS id 6EB5D6EC64 for ; Thu, 31 May 2018 15:53:15 +0000 (UTC) (envelope-from ronald-lists@klop.ws) Received: from smtp.greenhost.nl ([213.108.110.112]) by smarthost1.greenhost.nl with esmtps (TLS1.2:ECDHE_RSA_AES_128_GCM_SHA256:128) (Exim 4.84_2) (envelope-from ) id 1fOPt2-0000G8-L0 for freebsd-arm@freebsd.org; Thu, 31 May 2018 17:53:13 +0200 Content-Type: text/plain; charset=utf-8; format=flowed; delsp=yes To: freebsd-arm@freebsd.org Date: Thu, 31 May 2018 17:53:12 +0200 Subject: panic: Assertion td->td_lock == TDQ_LOCKPTR(tdq) failed at /usr/src/sys/kern/sched_ule.c:2137 MIME-Version: 1.0 Content-Transfer-Encoding: Quoted-Printable From: "Ronald Klop" Message-ID: User-Agent: Opera Mail/12.16 (FreeBSD) X-Authenticated-As-Hash: 398f5522cb258ce43cb679602f8cfe8b62a256d1 X-Virus-Scanned: by clamav at smarthost1.samage.net X-Spam-Level: / X-Spam-Score: -0.2 X-Spam-Status: No, score=-0.2 required=5.0 tests=ALL_TRUSTED, BAYES_50 autolearn=disabled version=3.4.0 X-Scan-Signature: fae0992e6f8dd0c1164808f182426692 X-BeenThere: freebsd-arm@freebsd.org X-Mailman-Version: 2.1.26 Precedence: list List-Id: "Porting FreeBSD to ARM processors." List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Thu, 31 May 2018 15:53:16 -0000 I had a crash on mu RPI-3B+ running freebsd 12/aarch64 from the 29 may = snapshot. It was building world -j4 and portsnap extract. I will keep it in the debugger for about an hour so if I need to provide= = more information, please mail me. db> show panic panic: Assertion td->td_lock =3D=3D TDQ_LOCKPTR(tdq) failed at = /usr/src/sys/kern/sched_ule.c:2137 db> bt Tracing pid 20 tid 100063 td 0xfffffd00014fe000 db_trace_self() at db_stack_trace+0xf0 pc =3D 0xffff0000006680f4 lr =3D 0xffff0000000d8b18 sp =3D 0xffff000053972e10 fp =3D 0xffff000053972e40 db_stack_trace() at db_command+0x220 pc =3D 0xffff0000000d8b18 lr =3D 0xffff0000000d879c sp =3D 0xffff000053972e50 fp =3D 0xffff000053972f30 db_command() at db_command_loop+0x60 pc =3D 0xffff0000000d879c lr =3D 0xffff0000000d8560 sp =3D 0xffff000053972f40 fp =3D 0xffff000053972f60 db_command_loop() at db_trap+0xf4 pc =3D 0xffff0000000d8560 lr =3D 0xffff0000000db678 sp =3D 0xffff000053972f70 fp =3D 0xffff000053973190 db_trap() at kdb_trap+0x1d8 pc =3D 0xffff0000000db678 lr =3D 0xffff0000003beca0 sp =3D 0xffff0000539731a0 fp =3D 0xffff000053973250 kdb_trap() at do_el1h_sync+0xf0 pc =3D 0xffff0000003beca0 lr =3D 0xffff000000683094 sp =3D 0xffff000053973260 fp =3D 0xffff000053973290 do_el1h_sync() at handle_el1h_sync+0x74 pc =3D 0xffff000000683094 lr =3D 0xffff00000066a074 sp =3D 0xffff0000539732a0 fp =3D 0xffff0000539733b0 handle_el1h_sync() at kdb_enter+0x34 pc =3D 0xffff00000066a074 lr =3D 0xffff0000003be34c sp =3D 0xffff0000539733c0 fp =3D 0xffff000053973450 kdb_enter() at vpanic+0x1c4 pc =3D 0xffff0000003be34c lr =3D 0xffff00000037a3a4 sp =3D 0xffff000053973460 fp =3D 0xffff000053973510 vpanic() at kassert_panic+0x1bc pc =3D 0xffff00000037a3a4 lr =3D 0xffff00000037a134 sp =3D 0xffff000053973520 fp =3D 0xffff0000539735d0 kassert_panic() at sched_switch+0x994 pc =3D 0xffff00000037a134 lr =3D 0xffff0000003a3d1c sp =3D 0xffff0000539735e0 fp =3D 0xffff0000539736c0 sched_switch() at mi_switch+0x1a0 pc =3D 0xffff0000003a3d1c lr =3D 0xffff000000385044 sp =3D 0xffff0000539736d0 fp =3D 0xffff0000539736f0 mi_switch() at uma_reclaim_locked+0x1cc pc =3D 0xffff000000385044 lr =3D 0xffff0000006169b4 sp =3D 0xffff000053973700 fp =3D 0xffff000053973750 uma_reclaim_locked() at uma_reclaim+0x34 pc =3D 0xffff0000006169b4 lr =3D 0xffff0000006167cc sp =3D 0xffff000053973760 fp =3D 0xffff000053973770 uma_reclaim() at vm_pageout_worker+0x3e8 pc =3D 0xffff0000006167cc lr =3D 0xffff000000636d08 sp =3D 0xffff000053973780 fp =3D 0xffff000053973b10 vm_pageout_worker() at vm_pageout+0x140 pc =3D 0xffff000000636d08 lr =3D 0xffff000000635b58 sp =3D 0xffff000053973b20 fp =3D 0xffff000053973b50 vm_pageout() at fork_exit+0x7c pc =3D 0xffff000000635b58 lr =3D 0xffff00000033bb14 sp =3D 0xffff000053973b60 fp =3D 0xffff000053973b90 fork_exit() at fork_trampoline+0x10 pc =3D 0xffff00000033bb14 lr =3D 0xffff000000682e14 sp =3D 0xffff000053973ba0 fp =3D 0x0000000000000000 Accidently I had this in a xterm: (da4s1b is the label/usbswap) dT: 1.008s w: 1.000s L(q) ops/s r/s kBps ms/r w/s kBps ms/w %busy Name 18 1 0 0 0.0 1 32 430.5 42.7| mmcsd0 0 0 0 0 0.0 0 0 0.0 0.0| da0 0 0 0 0 0.0 0 0 0.0 0.0| mmcsd0s1= 18 1 0 0 0.0 1 32 430.5 42.7| mmcsd0s2= 0 0 0 0 0.0 0 0 0.0 0.0| = msdosfs/MSDOSBOOT 18 1 0 0 0.0 1 32 430.5 42.7| mmcsd0s2= a 18 1 0 0 0.0 1 32 430.6 42.7| ufs/root= fs 0 0 0 0 0.0 0 0 0.0 0.0| da1 0 0 0 0 0.0 0 0 0.0 0.0| da2 0 0 0 0 0.0 0 0 0.0 0.0| da3 6 315 5 52 963.9 310 2158 11.6 92.6| da4 0 0 0 0 0.0 0 0 0.0 0.0| da2s1 0 0 0 0 0.0 0 0 0.0 0.0| da2s2 6 314 5 52 963.9 309 2158 11.6 92.6| da4s1 0 0 0 0 0.0 0 0 0.0 0.0| da2s2a 1 0 0 0 0.0 0 0 0.0 0.0| da4s1a 5 314 5 52 963.9 309 2158 11.6 92.6| da4s1b 0 0 0 0 0.0 0 0 0.0 0.0| = ufs/oldsdrootfs 1 0 0 0 0.0 0 0 0.0 0.0| = ufs/usbrootfs 5 314 5 52 963.9 309 2158 11.6 92.6| = label/usbswap =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80= =E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80=E2=94=80 last pid: 74521; load averages: 3.31, 3.34, = 3.72 up 0+17:21:58 = 17:19:13 63 processes: 3 running, 60 sleeping CPU 0: 3.9% user, 45.5% nice, 22.0% system, 2.4% interrupt, 26.3% idle= CPU 1: 1.2% user, 51.8% nice, 13.3% system, 0.4% interrupt, 33.3% idle= CPU 2: 2.0% user, 51.0% nice, 12.9% system, 0.0% interrupt, 34.1% idle= CPU 3: 1.2% user, 50.6% nice, 14.5% system, 0.8% interrupt, 32.9% idle= Mem: 522M Active, 132K Inact, 210M Laundry, 156M Wired, 60M Buf, 12M Fre= e Swap: 984M Total, 390M Used, 594M Free, 39% Inuse, 204K In, 3440K Out PID USERNAME THR PRI NICE SIZE RES STATE C TIME CP= U = COMMAND 73952 ronald 1 100 15 160M 97092K CPU3 3 0:39 82.81%= = c++ 73953 ronald 1 103 15 165M 106M CPU0 0 0:39 80.99%= = c++ 72549 ronald 1 52 15 517M 54008K swread 3 3:31 34.70%= = c++ 71551 ronald 1 52 15 448M 62524K swread 3 6:14 23.43%= = c++ 2806 ronald 1 21 0 30928K 2004K select 0 5:12 2.58= % = tmux 74521 root 1 52 0 15092K 5692K biord 1 0:00 2.18%= = bsdtar 94955 root 1 52 0 12660K 464K wait 1 5:03 0.71%= sh 53784 root 1 20 0 14220K 2568K nanslp 3 0:24 0.48%= = gstat 67541 ronald 1 20 0 13912K 2600K CPU1 1 0:06 0.30%= = top 53277 ronald 1 20 0 20992K 1464K select 0 0:07 0.18%= = sshd 94954 root 1 20 0 10820K 1800K pipewr 1 0:00 0.03%= = cat 746 root 1 20 0 17916K 18000K select 1 0:14 0.02= % = ntpd 5027 ronald 1 35 15 11048K 184K select 0 0:02 0.01= % = make 62849 ronald 1 35 15 14772K 468K select 0 0:06 0.01%= = make 2887 ronald 1 35 15 10348K 180K select 0 0:02 0.01= % = make