[Date Prev][Date Next] [Thread Prev][Thread Next] [Date Index] [Thread Index]

Re: ARAnyM VMs with Debian hanging at 100% CPU usage



Dixi quod…

>+ apt-get update

That’s actually indeed the freeze cause, just running that
(or LC_ALL=C apt-get update).

Log, including ^C press at the end:

Running Aranym headlessly
ARAnyM 0.9.13
Using config file: 'aranym.config.ssh'
Could not open joystick 0
ARAnyM RTC Timer: /dev/rtc: Device or resource busy
ARAnyM LILO: Error loading ramdisk 'root.bin'
Blitter tried to read byte from register ff8a00 at 007232
[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 3.2.0-3-atari (Debian 3.2.21-3) (debian-kernel@lists.debian.org) (gcc version 4.6.3 (Debian 4.6.3-7+m68k.2) ) #1 Sat Jun 30 06:00:58 UTC 2012
[    0.000000] Atari hardware found: VIDEL STDMA-SCSI ST_MFP YM2149 PCM CODEC DSP56K SCC ANALOG_JOY BLITTER IDE TT_CLK FDC_SPEED
[    0.000000] NatFeats found (ARAnyM, 1.0)
[    0.000000] Built 2 zonelists in Zone order, mobility grouping on.  Total pages: 198432
[    0.000000] Kernel command line: root=/dev/hda1 console=nfcon BOOT_IMAGE=vmlinux
[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Memory: 787060k/787060k available (2756k kernel code, 10864k data, 112k init)
[    0.000000] NR_IRQS:72
[    0.000000] Console: colour dummy device 80x25
[    0.000000] Calibrating delay loop... 96.66 BogoMIPS (lpj=483328)
[    0.090000] pid_max: default: 32768 minimum: 301
[    0.090000] Security Framework initialized
[    0.090000] AppArmor: AppArmor disabled by boot time parameter
[    0.090000] Mount-cache hash table entries: 512
[    0.090000] Initializing cgroup subsys cpuacct
[    0.090000] Initializing cgroup subsys memory
[    0.090000] Initializing cgroup subsys devices
[    0.090000] Initializing cgroup subsys freezer
[    0.090000] Initializing cgroup subsys blkio
[    0.090000] devtmpfs: initialized
[    0.100000] print_constraints: dummy:
[    0.100000] NET: Registered protocol family 16
[    0.120000] bio: create slab <bio-0> at 0
[    0.120000] SCSI subsystem initialized
[    0.160000] NET: Registered protocol family 2
[    0.160000] IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.170000] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
[    0.190000] TCP bind hash table entries: 65536 (order: 6, 262144 bytes)
[    0.190000] TCP: Hash tables configured (established 131072 bind 65536)
[    0.190000] TCP reno registered
[    0.190000] UDP hash table entries: 512 (order: 1, 8192 bytes)
[    0.190000] UDP-Lite hash table entries: 512 (order: 1, 8192 bytes)
[    0.190000] NET: Registered protocol family 1
[    0.200000] nfhd8: found device with 20971440 blocks (512 bytes)
[    0.200000]  nfhd8: AHDI p1 p2
[    0.200000] console [nfcon0] enabled
[    0.200000] nfeth: API 5
[    0.210000] eth0: nfeth addr:192.168.0.1 (192.168.0.2) HWaddr:52:54:00:22:00:01
[    0.210000] audit: initializing netlink socket (disabled)
[    0.210000] type=2000 audit(1340700471.210:1): initialized
[    0.210000] VFS: Disk quotas dquot_6.5.2
[    0.210000] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.210000] msgmni has been set to 1537
[    0.220000] alg: No test for stdrng (krng)
[    0.220000] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[    0.220000] io scheduler noop registered
[    0.220000] io scheduler deadline registered
[    0.220000] io scheduler cfq registered (default)
[    0.220000] atafb_init: start
[    0.220000] atafb_init: initializing Falcon hw
[    0.220000] atafb: screen_base 00b9b000 real_screen_base 00b9b000 screen_len 311296
[    0.220000] Determined 640x480, depth 4
[    0.220000]    virtual 640x972
[    0.230000] Console: switching to colour frame buffer device 80x30
[    0.240000] fb0: frame buffer device, using 304K of video memory
[    0.240000] Non-volatile memory driver v1.3
[    0.250000] Atari floppy driver: max. HD, track buffering
[    0.250000] Probing floppy drive(s):
[    0.250000] fd0
[    0.250000] Uniform Multi-Platform E-IDE driver
[    0.250000] ide: Falcon IDE controller
[    0.560000] hda: Master, ATA DISK drive
[    2.570000] ide0 at 0xfff00000 on irq 15 (serialized)
[    2.570000] ide-gd driver 1.18
[    2.570000] hda: max request size: 128KiB
[    2.570000] hda: 20971440 sectors (10737 MB) w/256KiB Cache, CHS=20805/16/63
[    2.590000]  hda: AHDI hda1 hda2
[    2.590000] ide-cd driver 5.00
[    2.590000] scsi0: options CAN_QUEUE=8 CMD_PER_LUN=1 SCAT-GAT=0 TAGGED-QUEUING=no HOSTID=7 generic options AUTOSENSE REAL DMA SCSI-2 TAGGED QUEUING generic release=7
[    2.590000] scsi0 : Atari native SCSI
[    2.590000] mousedev: PS/2 mouse device common for all mice
[    2.840000] input: Atari Keyboard as /devices/virtual/input/input0
[    2.840000] input: Atari mouse as /devices/virtual/input/input1
[    2.840000] blk_queue_max_segments: set to minimum 1
[    3.090000] blk_queue_max_segments: set to minimum 1
[    3.340000] blk_queue_max_segments: set to minimum 1
[    3.340000] rtc-generic rtc-generic: rtc core: registered rtc-generic as rtc0
[    3.340000] TCP cubic registered
[    3.340000] NET: Registered protocol family 17
[    3.340000] NET: Registered protocol family 15
[    3.340000] registered taskstats version 1
[    3.350000] scsi: waiting for bus probes to complete ...
[    3.610000] blk_queue_max_segments: set to minimum 1
[    3.860000] blk_queue_max_segments: set to minimum 1
[    4.110000] blk_queue_max_segments: set to minimum 1
[    4.360000] blk_queue_max_segments: set to minimum 1
[    4.660000] rtc-generic rtc-generic: setting system clock to 2012-07-26 08:47:56 UTC (1343292476)
[    4.660000] EXT4-fs (hda1): mounting ext3 file system using the ext4 subsystem
[    4.660000] EXT4-fs (hda1): INFO: recovery required on readonly filesystem
[    4.660000] EXT4-fs (hda1): write access will be enabled during recovery
[    8.200000] EXT4-fs (hda1): orphan cleanup on readonly fs
[    8.230000] EXT4-fs (hda1): 15 orphan inodes deleted
[    8.230000] EXT4-fs (hda1): recovery complete
[    8.250000] EXT4-fs (hda1): mounted filesystem with ordered data mode. Opts: (null)
[    8.250000] VFS: Mounted root (ext3 filesystem) readonly on device 3:1.
INIT: version 2.88 booting
Setting hostname to 'aranym.mirbsd.org'...done.
Starting the hotplug events dispatcher: udevd.
Synthesizing the initial hotplug events...done.
Waiting for /dev to be fully populated...done.
Activating swap:swapon on /dev/nfhd8p2
swapon: /dev/nfhd8p2: insecure permissions 1660, 0660 suggested.
swapon: /dev/nfhd8p2: found swap signature: version 1, page-size 4, same byte order
swapon: /dev/nfhd8p2: pagesize=4096, swapsize=2037374976, devsize=2037377024
[   17.820000] Adding 1989620k swap on /dev/nfhd8p2.  Priority:-1 extents:1 across:1989620k
.
[   18.040000] EXT4-fs (hda1): re-mounted. Opts: (null)
Will now check root file system:fsck from util-linux 2.20.1
[/sbin/fsck.ext3 (1) -- /run/rootdev] fsck.ext3 -a -C0 /run/rootdev
/run/rootdev: clean, 88975/1062880 files, 603701/2124023 blocks
.
[   18.400000] EXT4-fs (hda1): re-mounted. Opts: errors=remount-ro
Cleaning up temporary files...Cleaning /tmp...done.
 /tmpCleaning /lib/init/rw...done.
 /lib/init/rw.
Will now activate lvm and md swap:done.
Will now check all file systems.
fsck from util-linux 2.20.1
Checking all file systems.
Done checking file systems. A log is being saved in /var/log/fsck/checkfs if that location is writable..
Setting kernel variables ... /etc/sysctl.conf... /etc/sysctl.d/bindv6only.conf...sysctl: cannot stat /proc/sys/net/ipv6/bindv6only: No such file or directory
done.
Will now mount local filesystems:.
Will now activate swapfile swap:done.
Files under mount point '/tmp' will be hidden. ... (warning).
Cleaning up temporary files....
Configuring network interfaces...[   31.920000] ------------[ cut here ]------------
[   31.920000] WARNING: at /tmp/buildd/linux-3.2.21/kernel/irq/handle.c:130 handle_irq_event_percpu+0x130/0x13e()
[   31.920000] irq 3 handler nfeth_interrupt+0x0/0x190 enabled interrupts
[   31.920000] Modules linked in: evdev
[   31.920000] Call Trace: [<000304ae>] warn_slowpath_common+0x48/0x6a
[   31.920000]  [<000304bc>] warn_slowpath_common+0x56/0x6a
[   31.920000]  [<00030548>] warn_slowpath_fmt+0x2a/0x32
[   31.920000]  [<00066696>] handle_irq_event_percpu+0x130/0x13e
[   31.920000]  [<002ac106>] printk+0x0/0x18
[   31.920000]  [<00066696>] handle_irq_event_percpu+0x130/0x13e
[   31.920000]  [<0000a338>] nfeth_interrupt+0x0/0x190
[   31.920000]  [<000666c4>] handle_irq_event+0x20/0x2c
[   31.920000]  [<00065ecc>] generic_handle_irq+0x2c/0x3a
[   31.920000]  [<00002940>] do_IRQ+0x20/0x32
[   31.920000]  [<00002766>] auto_irqhandler_fixup+0x4/0x6
[   31.920000]
[   31.920000] ---[ end trace a43afb03be3db708 ]---
Restarting openntpd: ntpd.
[   34.130000] NET: Registered protocol family 10
Restarting openntpd: ntpd.
done.
Cleaning up temporary files....
Initializing random number generator...done.
Setting up X socket directories... /tmp/.X11-unix /tmp/.ICE-unix.
INIT: Entering runlevel: 2
Starting system log daemon....
Starting kernel log daemon....
Starting OpenBSD Secure Shell server: sshd.
Synchronising with 192.168.0.1 first.
Thu Jul 26 08:48:37 UTC 2012
rdate: adjust local clock by -0.442022 seconds
Starting openntpd: SSL tunnels disabled, see /etc/default/stunnel4
Starting Mail Transport Agent (MTA): sendmail.
Starting deferred execution scheduler: atd.
Starting periodic command scheduler: cron.
Running local boot scripts (/etc/rc.local)It may take up to one minute to decide whether rngd works.
Get statistics into syslog with: sudo pkill -USR1 rngd
Initialisation sequence complete.
.
[  156.110000] BUG: soft lockup - CPU#0 stuck for 22s! [https:1404]
[  156.110000] Modules linked in: ipv6 evdev
[  156.110000]
[  156.110000] Format 00  Vector: 0114  PC: 00006304  Status: 2300    Tainted: G        W
[  156.110000] ORIG_D0: ffffffff  D0: 00000007  A2: 30e83110  A1: 2e0f6000
[  156.110000] A0: 800216c8  D5: 00000000  D4: 2e105fcc
[  156.110000] D3: 00000100  D2: 00000505  D1: 00000007
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
                                                                              |
 A0: 30e83110 A4: 002aefee   D0: 00000000 D4: 2e105fcc  USP=efa46c14
 A1: 2e0f6000 A5: 2e105f38   D1: 00000001 D5: 00000000  ISP=2e105ee4
 A2: 30e83110 A6: 30ea9524   D2: 800216c8 D6: 00000084  MSP=00000000
 A3: 30ea94f0 A7: 2e105ee4   D3: 00000000 D7: 30ea94f0  VBR=0037f2a4
T=00 S=1 M=0 X=0 N=0 Z=1 V=0 C=0           TC=8000
CACR=80008000 DTT0=00000000 ITT0=00000000 SRP=00001000  SFC=001
CAAR=00000000 DTT1=fe00a040 ITT1=fe00a040 URP=2e0e9600  DFC=001
FP0: nan FP1: nan FP2: nan FP3: nan N=0 Z=0
FP4: nan FP5: nan FP6: nan FP7: nan I=0 NAN=0
0000702a: 6600 00c4 4a8b 6700 00be BNE.W #$00c4 == 000070f0 (FALSE)
next PC: 0000702e
>


bye,
//mirabilos
-- 
Solange man keine schmutzigen Tricks macht, und ich meine *wirklich*
schmutzige Tricks, wie bei einer doppelt verketteten Liste beide
Pointer XORen und in nur einem Word speichern, funktioniert Boehm ganz
hervorragend.		-- Andreas Bogk über boehm-gc in d.a.s.r


Reply to: