From owner-freebsd-ppc@freebsd.org Tue Aug 30 14:51:18 2016 Return-Path: Delivered-To: freebsd-ppc@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 6C4D0BC8DD7 for ; Tue, 30 Aug 2016 14:51:18 +0000 (UTC) (envelope-from nwhitehorn@freebsd.org) Received: from d.mail.sonic.net (d.mail.sonic.net [64.142.111.50]) (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 555AEB0 for ; Tue, 30 Aug 2016 14:51:17 +0000 (UTC) (envelope-from nwhitehorn@freebsd.org) Received: from zeppelin.tachypleus.net (75-101-50-44.static.sonic.net [75.101.50.44]) (authenticated bits=0) by d.mail.sonic.net (8.15.1/8.15.1) with ESMTPSA id u7UEpFZT017713 (version=TLSv1.2 cipher=DHE-RSA-AES128-SHA bits=128 verify=NOT) for ; Tue, 30 Aug 2016 07:51:16 -0700 Subject: Re: PPC64 on IBM KVM saga: 11.0 RC2 To: freebsd-ppc@freebsd.org References: <3rkxKP1cQczRRqR@baobab.bilink.it> <3s4y5N27LPz1cXL0@baobab.bilink.it> <3s5Tq62T6ZzRRrN@baobab.bilink.it> <70d56fc0-87f2-873d-5742-0bf6f0962890@freebsd.org> <3s6j6v5Sxnz1cXL0@baobab.bilink.it> <3s7CtJ43tXzRRr4@baobab.bilink.it> <3sNr3S632tz1cXKx@baobab.bilink.it> <6a5c265b-a2ca-5fd3-d53f-b7e6d83ef308@freebsd.org> <3sNrkv0GXCzRRqS@baobab.bilink.it> From: Nathan Whitehorn Message-ID: Date: Tue, 30 Aug 2016 07:51:15 -0700 User-Agent: Mozilla/5.0 (X11; FreeBSD amd64; rv:45.0) Gecko/20100101 Thunderbird/45.2.0 MIME-Version: 1.0 In-Reply-To: <3sNrkv0GXCzRRqS@baobab.bilink.it> Content-Type: text/plain; charset=windows-1252; format=flowed Content-Transfer-Encoding: 7bit X-Sonic-CAuth: UmFuZG9tSVa79qgEs8oaaMheHjwP3+zwhjzofftoMG6fJu8L0F9y5GxEfksJdt4OjuoaGZc6kh+JGkM3vMfE/Mxo44x88h6kDqUbm6PPaPE= X-Sonic-ID: C;AuOhM8Fu5hGu2a/hcgQksw== M;MhHpM8Fu5hGu2a/hcgQksw== X-Spam-Flag: No X-Sonic-Spam-Details: 0.0/5.0 by cerberusd X-BeenThere: freebsd-ppc@freebsd.org X-Mailman-Version: 2.1.22 Precedence: list List-Id: Porting FreeBSD to the PowerPC List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Tue, 30 Aug 2016 14:51:18 -0000 On 08/30/16 07:39, Luciano Mannucci wrote: > On Tue, 30 Aug 2016 07:18:45 -0700 > Nathan Whitehorn wrote: > >> That's disappointing. What is the error you get with RC2? >> -Nathan > It seems pretty similar to the previous one. BTW, here it is: Thanks! I found the regression (some changes to subr_taskqueue) and have informed the author and release engineering. Hopefully this makes it into the release. -Nathan > > Loading /boot/defaults/loader.conf > /boot/kernel/kernel data=0xfe0c70+0x3fded0 syms=[0x8+0x13d310+0x8+0x13c5de] > /boot/entropy size=0x1000 > > Hit [Enter] to boot immediately, or any other key for command prompt. > Booting [/boot/kernel/kernel] in 6 seconds... > > Type '?' for a list of commands, 'help' for more detailed help. > OK boot -v > Booting... > Kernel entry at 0x1023c0 ... > Copyright (c) 1992-2016 The FreeBSD Project. > Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994 > The Regents of the University of California. All rights reserved. > FreeBSD is a registered trademark of The FreeBSD Foundation. > FreeBSD 11.0-RC2 #0 r304729: Wed Aug 24 11:51:45 UTC 2016 > root@releng2.nyi.freebsd.org:/usr/obj/powerpc.powerpc64/usr/src/sys/GENERIC64 powerpc > gcc version 4.2.1 20070831 patched [FreeBSD] > VT: init without driver. > Preloaded elf kernel "/boot/kernel/kernel" at 0x175b000. > Preloaded /boot/entropy "/boot/entropy" at 0x175bd18. > cpu0: IBM POWER8E revision 2.1, 3425.00 MHz > cpu0: Features dc005180 > cpu0: Features2 c2000000 > real memory = 2110382080 (2012 MB) > available KVA = 7650267135 (7295 MB) > Physical memory chunk(s): > 0x0000000000025000 - 0x00000000000fffff, 897024 bytes (219 pages) > 0x0000000001811000 - 0x0000000001bfffff, 4124672 bytes (1007 pages) > 0x0000000001c40000 - 0x0000000001c3ffff, 0 bytes (0 pages) > 0x0000000003a49000 - 0x000000007ae6efff, 2000838656 bytes (488486 pages) > 0x000000007ffa0000 - 0x000000007ffaffff, 65536 bytes (16 pages) > 0x000000007ffb5000 - 0x000000007ffeffff, 241664 bytes (59 pages) > 0x000000007fff1000 - 0x000000007fffffff, 61440 bytes (15 pages) > 0x000000000175d000 - 0x00000000017fffff, 667648 bytes (163 pages) > avail memory = 1992290304 (1899 MB) > FreeBSD/SMP: Multiprocessor System Detected: 4 CPUs > cpu0: dev=7e5e0090 (BSP) > cpu8: dev=7e5e08b0 > cpu16: dev=7e5e10d0 > cpu24: dev=7e5e18f0 > random: read 4096 bytes from preloaded cache > random: unblocking device. > ULE: setup cpu 0 > ULE: setup cpu 8 > ULE: setup cpu 16 > ULE: setup cpu 24 > random: entropy device external interface > snd_unit_init() u=0x00ff8000 [512] d=0x00007c00 [32] c=0x000003ff [1024] > feeder_register: snd_unit=-1 snd_maxautovchans=16 latency=5 feeder_rate_min=1 feeder_rate_max=2016000 feeder_rate_round=25 > firmware: 'isp_1040' version 1: 22944 bytes loaded at 0xdd5d8c > firmware: 'isp_1080' version 1: 31350 bytes loaded at 0xddb72c > firmware: 'isp_12160' version 1: 28050 bytes loaded at 0xde31a2 > firmware: 'isp_2100' version 1: 76770 bytes loaded at 0xde9f34 > firmware: 'isp_2200' version 1: 84566 bytes loaded at 0xdfcb16 > firmware: 'isp_2300' version 1: 125252 bytes loaded at 0xe1156c > firmware: 'isp_2322' version 1: 120814 bytes loaded at 0xe2feb0 > firmware: 'isp_2400' version 1: 204384 bytes loaded at 0xe51218 > firmware: 'isp_2500' version 1: 223908 bytes loaded at 0xe90c48 > nfslock: pseudo-device > kbd0 at kbdmux0 > mem: > null: > openfirm: > random: harvesting attach, 8 bytes (4 bits) from nexus0 > ofwbus0: on nexus0 > random: harvesting attach, 8 bytes (4 bits) from ofwbus0 > xicp0: on ofwbus0 > random: harvesting attach, 8 bytes (4 bits) from xicp0 > cpulist0: on ofwbus0 > cpu0: on cpulist0 > random: harvesting attach, 8 bytes (4 bits) from cpu0 > cpu1: on cpulist0 > random: harvesting attach, 8 bytes (4 bits) from cpu1 > cpu2: on cpulist0 > random: harvesting attach, 8 bytes (4 bits) from cpu2 > cpu3: on cpulist0 > random: harvesting attach, 8 bytes (4 bits) from cpu3 > random: harvesting attach, 8 bytes (4 bits) from cpulist0 > pcib0: on ofwbus0 > pci0: on pcib0 > pci0: domain=0, physical bus=0 > found-> vendor=0x1af4, dev=0x1002, revid=0x00 > domain=0, bus=0, slot=3, func=0 > class=00-ff-00, hdrtype=0x00, mfdev=0 > cmdreg=0x0100, statreg=0x0000, cachelnsz=0 (dwords) > lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) > intpin=a, irq=0 > map[10]: type I/O Port, range 32, base 0x20, size 5, port disabled > found-> vendor=0x106b, dev=0x003f, revid=0x00 > domain=0, bus=0, slot=2, func=0 > class=0c-03-10, hdrtype=0x00, mfdev=0 > cmdreg=0x0106, statreg=0x0000, cachelnsz=0 (dwords) > lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) > intpin=a, irq=0 > map[10]: type Memory, range 32, base 0xc0000000, size 8, enabled > found-> vendor=0x10ec, dev=0x8139, revid=0x20 > domain=0, bus=0, slot=1, func=0 > class=02-00-00, hdrtype=0x00, mfdev=0 > cmdreg=0x0100, statreg=0x0000, cachelnsz=0 (dwords) > lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) > intpin=a, irq=0 > map[10]: type I/O Port, range 32, base 0x100, size 8, port disabled > map[14]: type Memory, range 32, base 0xc0000100, size 8, memory disabled > pci0: at device 3.0 (no driver attached) > ohci0: mem 0xc0000000-0xc00000ff irq 4100 at device 2.0 on pci0 > ohci0: Mapping IOMMU domain 0x80000000 > ofw_pci mapdev: start 100e0000000, len 256 > usbus0 on ohci0 > ohci0: usbpf: Attached > random: harvesting attach, 8 bytes (4 bits) from usbus0 > random: harvesting attach, 8 bytes (4 bits) from ohci0 > re0: port 0x100-0x1ff mem 0xc0000100-0xc00001ff irq 4099 at device 1.0 on pci0 > ofw_pci mapdev: start 100e0000100, len 256 > re0: MSI count : 0 > re0: MSI-X count : 0 > re0: Chip rev. 0x74800000 > re0: MAC rev. 0x00000000 > re0: Mapping IOMMU domain 0x80000000 > miibus0: on re0 > rlphy0: PHY 0 on miibus0 > rlphy0: OUI 0x000000, model 0x0000, rev. 0 > rlphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto, auto-flow > random: harvesting attach, 8 bytes (4 bits) from rlphy0 > random: harvesting attach, 8 bytes (4 bits) from miibus0 > re0: Using defaults for TSO: 65518/35/2048 > re0: bpf attached > re0: Ethernet address: 52:54:00:1a:cd:48 > random: harvesting attach, 8 bytes (4 bits) from re0 > random: harvesting attach, 8 bytes (4 bits) from pci0 > random: harvesting attach, 8 bytes (4 bits) from pcib0 > rtas0: on ofwbus0 > rtas0: registered as a time-of-day clock (resolution 2000us, adjustment 0.001000000s) > random: harvesting attach, 8 bytes (4 bits) from rtas0 > vdevice0: on ofwbus0 > vscsi0: irq 16781319 on vdevice0 > vscsi0: Mapping IOMMU domain 0x2000 > vscsi0: Queue depth 22 commands > random: harvesting attach, 8 bytes (4 bits) from vscsi0 > uart0: irq 16781320 on vdevice0 > random: harvesting attach, 8 bytes (4 bits) from uart0 > random: harvesting attach, 8 bytes (4 bits) from vdevice0 > ofwbus0: compat linux,kvm (no driver attached) > procfs registered > Timecounter "timebase" frequency 512000000 Hz quality 0 > Event timer "decrementer" frequency 512000000 Hz quality 1000 > Timecounters tick every 1.000 msec > vlan: initialized, using hash tables with chaining > lo0: bpf attached > tcp_init: net.inet.tcp.tcbhashsize auto tuned to 16384 > usbus0: 12Mbps Full Speed USB v1.0 > (probe0:vscsi0:0:0:0): Down reving Protocol Version from 6 to 5? > ugen0.1: at usbus0 > uhub0: on usbus0 > (probe0:vscsi0:0:0:1): Down reving Protocol Version from 6 to 5? > pass0 at vscsi0 bus 0 scbus0 target 0 lun 0 > pass0: Fixed Direct Access SPC-3 SCSI device > pass0: 150.000MB/s transfers > pass1 at vscsi0 bus 0 scbus0 target 0 lun 1 > pass1: Removable CD-ROM SPC-3 SCSI device > pass1: 150.000MB/s transfers > cd0 at vscsi0 bus 0 scbus0 target 0 lun 1 > cd0: Removable CD-ROM SPC-3 SCSI device > cd0: 150.000MB/s transfers > cd0: 592MB (303319 2048 byte sectors) > da0 at vscsi0 bus 0 scbus0 target 0 lun 0 > da0: Fixed Direct Access SPC-3 SCSI device > da0: 150.000MB/s transfers > da0: 20480MB (41943040 512 byte sectors) > Adding CPU 0, pir=68, awake=1 > Waking up CPU 8 (dev=7e5e08b0) > Adding CPU 8, pir=860, awake=1 > Waking up CPU 16 (dev=7e5e10d0) > Adding CPU 16, pir=860, awake=1 > Waking up CPU 24 (dev=7e5e18f0) > Adding CPU 24, pir=860, awake=1 > SMP: AP CPU #24 launched > SMP: AP CPU #8 launched > SMP: AP CPU #16 launched > spin lock 0x1250900 (sched lock 0) held by 0x48f89c0 (tid 100052) too long > spin lock 0x1250900 (sched lock 0) held by 0x48f89c0 (tid 100052) too long > timeout stopping cpus > panic: spin lock held too long > cpuid = 8 > KDB: stack backtrace: > #0 0x6144fc at ??+0 > #1 0x614598 at ??+0 > #2 0x5eac60 at ??+0 > #3 0x5eaef4 at ??+0 > #4 0x65d1a0 at ??+0 > #5 0x661040 at ??+0 > #6 0x6240c0 at ??+0 > #7 0x65ef18 at ??+0 > #8 0x67b658 at ??+0 > #9 0x679398 at ??+0 > #10 0x67c03c at ??+0 > #11 0x5b233c at ??+0 > #12 0xa6c620 at ??+0 > #13 0xa6c4f4 at ??+0 > Uptime: 1s > timeout stopping cpus > panic: spin lock held too long > cpuid = 16 > Uptime: 1s > > Obviously, with only one CPU everything seems fine... > > Cheers, > > Luciano.