From owner-freebsd-arm@freebsd.org Sun Nov 19 08:15:55 2017 Return-Path: Delivered-To: freebsd-arm@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 A316FDEF2A5 for ; Sun, 19 Nov 2017 08:15:55 +0000 (UTC) (envelope-from markmi@dsl-only.net) Received: from asp.reflexion.net (outbound-mail-210-158.reflexion.net [208.70.210.158]) (using TLSv1.2 with cipher ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)) (Client did not present a certificate) by mx1.freebsd.org (Postfix) with ESMTPS id 6A0E56FCF0 for ; Sun, 19 Nov 2017 08:15:54 +0000 (UTC) (envelope-from markmi@dsl-only.net) Received: (qmail 28471 invoked from network); 19 Nov 2017 08:15:48 -0000 Received: from unknown (HELO rtc-sm-01.app.dca.reflexion.local) (10.81.150.1) by 0 (rfx-qmail) with SMTP; 19 Nov 2017 08:15:48 -0000 Received: by rtc-sm-01.app.dca.reflexion.local (Reflexion email security v8.40.3) with SMTP; Sun, 19 Nov 2017 03:15:48 -0500 (EST) Received: (qmail 21982 invoked from network); 19 Nov 2017 08:15:48 -0000 Received: from unknown (HELO iron2.pdx.net) (69.64.224.71) by 0 (rfx-qmail) with (AES256-SHA encrypted) SMTP; 19 Nov 2017 08:15:48 -0000 Received: from [192.168.1.25] (c-76-115-7-162.hsd1.or.comcast.net [76.115.7.162]) by iron2.pdx.net (Postfix) with ESMTPSA id 9265AEC88F5; Sun, 19 Nov 2017 00:15:47 -0800 (PST) Content-Type: text/plain; charset=us-ascii Mime-Version: 1.0 (Mac OS X Mail 10.3 \(3273\)) Subject: Re: ssh sessions close spontaneously on rpi2 [Also: I got a rpi2 'Translation Fault (L1)' crash that I also report here, -r325700 based context] From: Mark Millard In-Reply-To: Date: Sun, 19 Nov 2017 00:15:47 -0800 Cc: Freebsd-arm Content-Transfer-Encoding: quoted-printable Message-Id: References: <20171118165638.GA47956@www.zefox.net> <1A09ACF9-1A85-480D-90BD-9886FC54D116@dsl-only.net> To: bob prohaska X-Mailer: Apple Mail (2.3273) X-BeenThere: freebsd-arm@freebsd.org X-Mailman-Version: 2.1.25 Precedence: list List-Id: "Porting FreeBSD to ARM processors." List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Sun, 19 Nov 2017 08:15:55 -0000 Do you get any messages like: smsc0: warning: Failed to read register 0x114 smsc0: warning: MII is busy . . . smsc0: warning: Failed to write register 0x114 . . . smsc0: warning: Failed to read register 0x118 smsc0: warning: Failed to read register 0x114 smsc0: warning: MII is busy . . . smsc0: warning: Failed to read register 0x114 smsc0: warning: MII read timeout I am seeing these while a svnlite update is going against the mmcsd0 and a portmaster build of pkg is going against a USB SSD. (The active root file system is on the USB SSD.) [Later. . .] The ssh session that was running the svnlite update eventually got: packet_write_wait: Connection to 192.168.1.112 port 22: Broken pipe [Process completed] Another ssh session (idle sitting at a prompt) was still working after that. The portmaster build of pkg was via the serial console instead of via ethernet and ssh. For reference: smsc0 on uhub1 smsc0: on usbus0 smsc0: chip 0xec00, rev. 0002 miibus0: on smsc0 smscphy0: PHY 1 on miibus0 smscphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto . . . smsc0: chip 0xec00, rev. 0002 [Even later:] Eventually the rpi2 crashed with: slot0: Controller timeout sdhci_bcm0-slot0: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D REGISTER = DUMP =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D sdhci_bcm0-slot0: Sys addr: 0x36003200 | Version: 0x00009902 sdhci_bcm0-slot0: Blk size: 0x00000200 | Blk cnt: 0x0000003f sdhci_bcm0-slot0: Argument: 0x01163b00 | Trn mode: 0x0000193a sdhci_bcm0-slot0: Present: 0x01ff0506 | Host ctl: 0x00000003 sdhci_bcm0-slot0: Power: 0x0000000f | Blk gap: 0x00000000 sdhci_bcm0-slot0: Wake-up: 0x00000000 | Clock: 0x00000307 sdhci_bcm0-slot0: Timeout: 0x0000000e | Int stat: 0x00000010 sdhci_bcm0-slot0: Int enab: 0x01ff00bb | Sig enab: 0x01ff0089 sdhci_bcm0-slot0: AC12 err: 0x00000000 | Host ctl2:0x00000000 sdhci_bcm0-slot0: Caps: 0x00000000 | Caps2: 0x00000000 sdhci_bcm0-slot0: Max curr: 0x00000001 | ADMA err: 0x00000000 sdhci_bcm0-slot0: ADMA addr:0x00000000 | Slot int: 0x00000000 sdhci_bcm0-slot0: =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D Fatal kernel mode data abort: 'Translation Fault (L1)' on read trapframe: 0xe4cd1cf8 FSR=3D00000005, FAR=3D00000024, spsr=3D60000013 r0 =3Dc3885c00, r1 =3Dc3880780, r2 =3D00000000, r3 =3D00000000 r4 =3Dc3a5c600, r5 =3Dc388e648, r6 =3D00000001, r7 =3Dc3a5c630 r8 =3Dc0869490, r9 =3Dc086a828, r10=3Dc388e600, r11=3De4cd1db0 r12=3D00000029, ssp=3De4cd1d88, slr=3Dc027895c, pc =3Dc062eaf4 [ thread pid 11 tid 100035 ] Stopped at bcm_sdhci_dma_intr+0xb8: ldr r2, [r2, #0x024] db> bt Tracing pid 11 tid 100035 td 0xc39a6740 db_trace_self() at db_trace_self pc =3D 0xc05c6d24 lr =3D 0xc005eab4 (db_stack_trace+0x108) sp =3D 0xe4cd1a08 fp =3D 0xe4cd1a20 db_stack_trace() at db_stack_trace+0x108 pc =3D 0xc005eab4 lr =3D 0xc005e714 (db_command+0x268) sp =3D 0xe4cd1a28 fp =3D 0xe4cd1ac8 r4 =3D 0x00000001 r5 =3D 0x00000000 r6 =3D 0xc0734fef r10 =3D 0x00000000 db_command() at db_command+0x268 pc =3D 0xc005e714 lr =3D 0xc005e49c (db_command_loop+0x74) sp =3D 0xe4cd1ad0 fp =3D 0xe4cd1ae0 r4 =3D 0xc06e9458 r5 =3D 0xc071184e r6 =3D 0xc099cfa4 r7 =3D 0xe4cd1cf8 r8 =3D 0xc07fcb38 r9 =3D 0xc086a860 r10 =3D 0xc098bcd0 db_command_loop() at db_command_loop+0x74 pc =3D 0xc005e49c lr =3D 0xc0061f24 (db_trap+0x12c) sp =3D 0xe4cd1ae8 fp =3D 0xe4cd1c00 r4 =3D 0x00000000 r5 =3D 0xc099cfb0 r6 =3D 0xc098bcf0 r10 =3D 0xc098bcd0 db_trap() at db_trap+0x12c pc =3D 0xc0061f24 lr =3D 0xc02e27a8 (kdb_trap+0x16c) sp =3D 0xe4cd1c08 fp =3D 0xe4cd1c30 r4 =3D 0x00000000 r5 =3D 0x00000005 r6 =3D 0xc098bcf0 r7 =3D 0xe4cd1cf8 kdb_trap() at kdb_trap+0x16c pc =3D 0xc02e27a8 lr =3D 0xc05ea50c (abort_fatal+0x20c) sp =3D 0xe4cd1c38 fp =3D 0xe4cd1c58 r4 =3D 0xe4cd1cf8 r5 =3D 0x00000013 r6 =3D 0x00000024 r7 =3D 0x00000005 r8 =3D 0x00000005 r9 =3D 0xc39a6740 r10 =3D 0xe4cd1cf8 abort_fatal() at abort_fatal+0x20c pc =3D 0xc05ea50c lr =3D 0xc05ea170 (abort_handler+0x318) sp =3D 0xe4cd1c60 fp =3D 0xe4cd1cf0 r4 =3D 0x00000005 r5 =3D 0x00000005 r6 =3D 0x00000000 r7 =3D 0x00000005 r8 =3D 0x00000013 r10 =3D 0xe4cd1cf8 abort_handler() at abort_handler+0x318 pc =3D 0xc05ea170 lr =3D 0xc05c9720 (exception_exit) sp =3D 0xe4cd1cf8 fp =3D 0xe4cd1db0 r4 =3D 0xc3a5c600 r5 =3D 0xc388e648 r6 =3D 0x00000001 r7 =3D 0xc3a5c630 r8 =3D 0xc0869490 r9 =3D 0xc086a828 r10 =3D 0xc388e600 exception_exit() at exception_exit pc =3D 0xc05c9720 lr =3D 0xc027895c (__mtx_lock_sleep+0x1ec) sp =3D 0xe4cd1d88 fp =3D 0xe4cd1db0 r0 =3D 0xc3885c00 r1 =3D 0xc3880780 r2 =3D 0x00000000 r3 =3D 0x00000000 r4 =3D 0xc3a5c600 r5 =3D 0xc388e648 r6 =3D 0x00000001 r7 =3D 0xc3a5c630 r8 =3D 0xc0869490 r9 =3D 0xc086a828 r10 =3D 0xc388e600 r12 =3D 0x00000029 bcm_sdhci_dma_intr() at bcm_sdhci_dma_intr+0xb8 pc =3D 0xc062eaf4 lr =3D 0xc02594c4 = (intr_event_execute_handlers+0x118) sp =3D 0xe4cd1db8 fp =3D 0xe4cd1dd8 r4 =3D 0xc38faee0 r5 =3D 0xc388e648 r6 =3D 0x00000000 r7 =3D 0xc389b840 r8 =3D 0xc0869490 r9 =3D 0xc086a828 r10 =3D 0xc388e600 intr_event_execute_handlers() at intr_event_execute_handlers+0x118 pc =3D 0xc02594c4 lr =3D 0xc0259c20 (ithread_loop+0x15c) sp =3D 0xe4cd1de0 fp =3D 0xe4cd1e18 r4 =3D 0xc38faee0 r5 =3D 0xc388e670 r6 =3D 0xc388e600 r7 =3D 0xc388e610 r8 =3D 0xc38faeec r9 =3D 0xc0828ba0 r10 =3D 0x00000000 ithread_loop() at ithread_loop+0x15c pc =3D 0xc0259c20 lr =3D 0xc0255e20 (fork_exit+0xc0) sp =3D 0xe4cd1e20 fp =3D 0xe4cd1e40 r4 =3D 0xc39a6740 r5 =3D 0xc38b3730 r6 =3D 0xc0259ac4 r7 =3D 0xc38faee0 r8 =3D 0xe4cd1e48 r9 =3D 0x00000000 r10 =3D 0x00000000 fork_exit() at fork_exit+0xc0 pc =3D 0xc0255e20 lr =3D 0xc05c96b0 (swi_exit) sp =3D 0xe4cd1e48 fp =3D 0x00000000 r4 =3D 0xc0259ac4 r5 =3D 0xc38faee0 r6 =3D 0x00000000 r7 =3D 0x00000000 r8 =3D 0x00000000 r10 =3D 0x00000000 swi_exit() at swi_exit pc =3D 0xc05c96b0 lr =3D 0xc05c96b0 (swi_exit) sp =3D 0xe4cd1e48 fp =3D 0x00000000 db>=20 I notice during boot I get: Booting [/boot/kernel/kernel]... =20 /boot/dtb/bcm2836-rpi-2-b.dtb size=3D0x346b Loaded DTB from file 'bcm2836-rpi-2-b.dtb'. That last seems to indicate that the DTB is from FreeBSD instead of from the rpi-firmware or u-boot-rpi2 in my context. For reference: U-Boot 2017.09 (Nov 18 2017 - 07:51:46 +0000) DRAM: 960 MiB RPI 2 Model B (0xa21041) MMC: sdhci@7e300000: 0 . . . Compatible U-Boot API signature found @0x3bb5d988 FreeBSD/armv7 U-Boot loader, Revision 1.2 DRAM: 960MB Number of U-Boot devices: 2 U-Boot env: loaderdev not set, will probe all devices. Found U-Boot device: disk Probing all disk devices... Checking unit=3D0 slice=3D partition=3D... good. Booting from disk0p1: /boot/kernel/kernel data=3D0x87035c+0x183ca4 = syms=3D[0x4+0x93890+0x4+0xd7368] /boot/kernel/geom_label.ko text=3D0x47b8 data=3D0x868+0x4 = syms=3D[0x4+0xd90+0x4+0xfb6] =3D=3D=3D Mark Millard markmi at dsl-only.net