Re: FreeBSD startup timer hangs on boot

2011-05-25 Thread Nikita A Menkovich
Problem solved by upgrading to 2.6.39 kernel from 2.6.38, at another
server I use 2.6.38 kernel, but there is no such problem
Seems some problem between newer versions of qemu-kvm and kvm kernel
version and also result of fixing KVM: fix kvmclock regression due to
missing clock update


On 24 May 2011 16:43, Nikita A Menkovich menkov...@gmail.com wrote:
 Hello,

 I receive strange problem with running FreeBSD guest (7 and 8, x86 and
 amd64) on KVM.
 When begins boot menu, there is time countdown 10..9..8 etc, and time
 between 10 and 9 can be different than 1 sec 0.9, 1.1 etc.
 And sometimes countdown hangs on some number.

 QEMU emulator version 0.14.0 (qemu-kvm-0.14.0 Debian
 0.14.0+dfsg-1~tls), Copyright (c) 2003-2008 Fabrice Bellard
 libvirt 0.9.1
 Linux  2.6.38  x86_64

 libvirt.xml http://pastebin.com/03vJKhVc

 strace -c -p VMPID


 % time     seconds  usecs/call     calls    errors syscall
 -- --- --- - - 
  99.81    2.432429         334      7277           select
  0.11    0.002591           0     18310           timer_gettime
  0.06    0.001355           0     14404           ioctl
  0.01    0.000218           0     10542      3514 read
  0.01    0.000217           0      3514           timer_settime
  0.00    0.70           0      3514           rt_sigaction
  0.00    0.53           0      3869           write
  0.00    0.33           0       303           recvmsg
 -- --- --- - - 
 100.00    2.436966                 61733      3514 total


 strace -p VMPID


 write(7, \1\0\0\0\0\0\0\0, 8)         = 8
 read(13, 0x7fff119dae90, 128)           = -1 EAGAIN (Resource
 temporarily unavailable)
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 0}}) = 0
 timer_settime(0x2, 0, {it_interval={0, 0}, it_value={0, 25}}, NULL) = 0
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 138172}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 select(16, [6 9 12 13 14 15], [], [], {1, 0}) = 1 (in [6], left {0, 98})
 read(6, \1\0\0\0\0\0\0\0, 512)        = 8
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 select(16, [6 9 12 13 14 15], [], [], {1, 0}) = 1 (in [13], left {0, 998108})
 read(13, 
 \16\0\0\0\0\0\0\0\376\377\377\377\0\0\0\0\0\0\0\0\0\0\0\0\2\0\0\0\0\0\0\0...,
 128) = 128
 rt_sigaction(SIGALRM, NULL, {0x4d0490, ~[KILL STOP RTMIN RT_1],
 SA_RESTORER, 0x7fb09b6c9f60}, 8) = 0
 write(7, \1\0\0\0\0\0\0\0, 8)         = 8
 read(13, 0x7fff119dae90, 128)           = -1 EAGAIN (Resource
 temporarily unavailable)
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 0}}) = 0
 timer_settime(0x2, 0, {it_interval={0, 0}, it_value={0, 25}}, NULL) = 0
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 144317}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 select(16, [6 9 12 13 14 15], [], [], {1, 0}) = 1 (in [6], left {0, 98})
 read(6, \1\0\0\0\0\0\0\0, 512)        = 8
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 select(16, [6 9 12 13 14 15], [], [], {1, 0}) = 1 (in [13], left {0, 997811})
 read(13, 
 \16\0\0\0\0\0\0\0\376\377\377\377\0\0\0\0\0\0\0\0\0\0\0\0\2\0\0\0\0\0\0\0...,
 128) = 128
 rt_sigaction(SIGALRM, NULL, {0x4d0490, ~[KILL STOP RTMIN RT_1],
 SA_RESTORER, 0x7fb09b6c9f60}, 8) = 0
 write(7, \1\0\0\0\0\0\0\0, 8)         = 8
 read(13, 0x7fff119dae90, 128)           = -1 EAGAIN (Resource
 temporarily unavailable)
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 0}}) = 0
 timer_settime(0x2, 0, {it_interval={0, 0}, it_value={0, 25}}, NULL) = 0
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 133651}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 select(16, [6 9 12 13 14 15], [], [], {1, 0}) = 1 (in [6], left {0, 98})
 read(6, \1\0\0\0\0\0\0\0, 512)        = 8
 timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
 ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
 select(16, [6 9 12 13 14 15], [], [], {1, 0}) = 1 (in [13], left {0, 998027})
 read(13, 
 \16\0\0\0\0\0\0\0\376\377\377\377\0\0\0\0\0\0\0\0\0\0\0\0\2\0\0\0\0\0\0\0...,
 128) = 128
 rt_sigaction(SIGALRM, NULL, {0x4d0490, ~[KILL STOP RTMIN RT_1],
 SA_RESTORER

FreeBSD startup timer hangs on boot

2011-05-24 Thread Nikita A Menkovich
, {it_interval={0, 0}, it_value={0, 1}}) = 0
ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
select(16, [6 9 12 13 14 15], [], [], {1, 0}) = 1 (in [6], left {0, 98})
read(6, \1\0\0\0\0\0\0\0, 512)= 8
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
select(16, [6 9 12 13 14 15], [], [], {1, 0}) = 1 (in [13], left {0, 998035})
read(13, 
\16\0\0\0\0\0\0\0\376\377\377\377\0\0\0\0\0\0\0\0\0\0\0\0\2\0\0\0\0\0\0\0...,
128) = 128
rt_sigaction(SIGALRM, NULL, {0x4d0490, ~[KILL STOP RTMIN RT_1],
SA_RESTORER, 0x7fb09b6c9f60}, 8) = 0
write(7, \1\0\0\0\0\0\0\0, 8) = 8
read(13, 0x7fff119dae90, 128)   = -1 EAGAIN (Resource
temporarily unavailable)
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 0}}) = 0
timer_settime(0x2, 0, {it_interval={0, 0}, it_value={0, 25}}, NULL) = 0
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 139724}}) = 0
ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
select(16, [6 9 12 13 14 15], [], [], {1, 0}) = 1 (in [6], left {0, 98})
read(6, \1\0\0\0\0\0\0\0, 512)= 8
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
select(16, [6 9 12 13 14 15], [], [], {1, 0}) = 1 (in [13], left {0, 997792})
read(13, 
\16\0\0\0\0\0\0\0\376\377\377\377\0\0\0\0\0\0\0\0\0\0\0\0\2\0\0\0\0\0\0\0...,
128) = 128
rt_sigaction(SIGALRM, NULL, {0x4d0490, ~[KILL STOP RTMIN RT_1],
SA_RESTORER, 0x7fb09b6c9f60}, 8) = 0
write(7, \1\0\0\0\0\0\0\0, 8) = 8
read(13, 0x7fff119dae90, 128)   = -1 EAGAIN (Resource
temporarily unavailable)
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 0}}) = 0
timer_settime(0x2, 0, {it_interval={0, 0}, it_value={0, 25}}, NULL) = 0
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 139130}}) = 0
ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
select(16, [6 9 12 13 14 15], [], [], {1, 0}) = 1 (in [6], left {0, 98})
read(6, \1\0\0\0\0\0\0\0, 512)= 8
timer_gettime(0x2, {it_interval={0, 0}, it_value={0, 1}}) = 0
ioctl(5, KVM_IRQ_LINE_STATUS, 0x7fff119daeb0) = 0
select(16, [6 9 12 13 14 15], [], [], {1, 0} unfinished ...

Sometime boot do not hang on coundown and guest boots fine.

-- 
Nikita A Menkovich
http://libc6.org/
JID: menkov...@gmail.com
--
To unsubscribe from this list: send the line unsubscribe kvm in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html