qemu-devel
[Top][All Lists]
Advanced

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

Re: [Qemu-devel] [Nbd] Hibernate and qemu-nbd


From: Mark Trumpold
Subject: Re: [Qemu-devel] [Nbd] Hibernate and qemu-nbd
Date: Thu, 17 Oct 2013 17:07:07 +0000

>-----Original Message-----
>From: Stefan Hajnoczi [mailto:address@hidden
>Sent: Tuesday, October 15, 2013 08:17 AM
>To: 'Mark Trumpold'
>Cc: 'Wouter Verhelst', address@hidden, 'Paul Clements',
>address@hidden, 'Paolo Bonzini'
>Subject: Re: [Nbd] [Qemu-devel] Hibernate and qemu-nbd
>
>On Thu, Oct 10, 2013 at 11:15 AM, Stefan Hajnoczi <address@hidden> wrote:
>> On Fri, Oct 04, 2013 at 07:30:45AM -0700, Mark Trumpold wrote:
>>>
>>>
>>> On 9/26/13 10:18 PM, "Stefan Hajnoczi" <address@hidden> wrote:
>>>
>>> >
>>> >Try the qemu-nbd --persistent option.  That should prevent it from
>>> >shutting down when nbd-client is disconnected.
>>> >
>>> >Stefan
>>> >
>>>
>>>
>>> Hi Stefan,
>>>
>>> Sorry for the delay..
>>> I tried the following per your suggestion:
>>>
>>>   920  qemu-nbd --persistent -p 2000 /root/qemu/q1.img &
>>>   921  nbd-client -persist localhost 2000 /dev/nbd0
>>>   922  fsck /dev/nbd0
>>>   923  mount /dev/nbd0 /mnt
>>>   924  ls /mnt
>>>   925  umount /dev/nbd0
>>>   ::
>>>
>>>   927  echo reboot >/sys/power/disk
>>>   928  echo disk >/sys/power/state
>>>   929  mount /dev/nbd0 /mnt
>>>
>>> This seems to work; that is both sides (client and server) persist
>>> after the hibernate cycle.
>>>
>>> However, if I don't 'umount' '/dev/nbd0' before the hibernate
>>> cycle, and try to 'ls /mnt' after, the 'ls' hangs indefinitely.
>>>
>>> For my real use case we have the root filesystem mounted,
>>> so unmounting is not an option (at least I don't think so).
>>>
>>> I also tried remounting readonly, and also 'blockdev --flushbufs ..'
>>> before the hibernate cycle -- either or both did not help.
>>>
>>> I had thought about trying a 'chroot' and then a 'umount', but
>>> have not yet tried this.
>>>
>>> This one was so close..
>
>Could you try drop the umount/mount and capture the following straces:
>strace -p $(pgrep nbd-client) -o /var/tmp/nbd-client.strace
>strace -p $(pgrep qemu-nbd) -o /var/tmp/qemu-nbd.strace
>
>In particular, let's find out what happens when you run ls /mnt after
>resuming the machine.  The nbd-client should reconnect to qemu-nbd and
>I/O requests would flow to qemu-nbd again.  But something is stuck;
>the problem might be clear from the strace output.
>
>Stefan
>

Hi Stefan,

Following are:
  1) test scenario commands
  2) strace from nbd-client
  3) strace from qemu-nbd (quite lengthy - 598 lines)
  4) kernel oops output when I 'halt' after the test scenario.

Thank you,
Mark T.


1) ==========

  162  qemu-nbd --persistent -p 2000 /root/qemu/q1.img &
  163  nbd-client -persist localhost 2000 /dev/nbd0
  165  strace -p 2488 -o /var/tmp/qemu.nbd.strace.v2 &
  166  strace -p 2492 -o /var/tmp/nbd-client.strace.v2 &

  168  mount /dev/nbd0 /mnt
  169  ls /mnt

  172  echo reboot >/sys/power/disk
  173  echo disk >/sys/power/state

  180  ls /mnt    <-- hangs



2) ==========

write(2, "Kernel call returned: Interrupte"..., 45) = 45
write(2, " Reconnecting\n", 14)         = 14
close(4)                                = 0
close(3)                                = 0
socket(PF_NETLINK, SOCK_RAW, 0)         = 3
bind(3, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 0
getsockname(3, {sa_family=AF_NETLINK, pid=2492, groups=00000000}, [12]) = 0
time(NULL)                              = 1381947917
sendto(3, "\24\0\0\0\26\0\1\3\r\332^R\0\0\0\0\0\0\0\0", 20, 0, 
{sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 20
recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, 
msg_iov(1)=[{"0\0\0\0\24\0\2\0\r\332^R\274\t\0\0\2\10\200\376\1\0\0\0\10\0\1\0\177\0\0\1"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 108
recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, 
msg_iov(1)=[{"@\0\0\0\24\0\2\0\r\332^R\274\t\0\0\n\200\200\376\1\0\0\0\24\0\1\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 192
recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, 
msg_iov(1)=[{"\24\0\0\0\3\0\2\0\r\332^R\274\t\0\0\0\0\0\0\1\0\0\0\24\0\1\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 20
close(3)                                = 0
stat64("/etc/resolv.conf", {st_mode=S_IFREG|0644, st_size=82, ...}) = 0
open("/etc/resolv.conf", O_RDONLY)      = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=82, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb7734000
read(3, "domain dvt.tachyon.net\nsearch dv"..., 4096) = 82
read(3, "", 4096)                       = 0
close(3)                                = 0
munmap(0xb7734000, 4096)                = 0
open("/etc/hosts", O_RDONLY|O_CLOEXEC)  = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=220, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 
0xb7734000
read(3, "127.0.0.1  localhost\n127.0.1.1  "..., 4096) = 220
read(3, "", 4096)                       = 0
close(3)                                = 0
munmap(0xb7734000, 4096)                = 0
socket(PF_INET, SOCK_STREAM, IPPROTO_TCP) = 3
connect(3, {sa_family=AF_INET, sin_port=htons(2000), 
sin_addr=inet_addr("127.0.0.1")}, 16) = 0
setsockopt(3, SOL_TCP, TCP_NODELAY, [1], 4) = 0
open("/dev/nbd0", O_RDWR|O_LARGEFILE)   = 4
write(1, "Negotiation: ", 13)           = 13
read(3, "NBDMAGIC", 8)                  = 8
write(1, ".", 1)                        = 1
read(3, "\0\0B\2\201\206\22S", 8)       = 8
write(1, ".", 1)                        = 1
read(3, "\0\0\0\0\200\0\0\0", 8)        = 8
write(1, "size = 2097152KB", 16)        = 16
read(3, "\0\0\0-", 4)                   = 4
read(3, "\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 
124) = 124
write(1, "\n", 1)                       = 1
ioctl(4, NBD_SET_BLKSIZE, 0x400)        = 0
ioctl(4, NBD_SET_SIZE_BLOCKS, 0x200000) = 0
write(2, "bs=1024, sz=2097152\n", 20)   = 20
ioctl(4, NBD_CLEAR_SOCK, 0x400)         = 0
ioctl(4, BLKROSET, 0xbff015bc)          = 0
ioctl(4, NBD_SET_SOCK, 0x3)             = 0
clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, 
child_tidptr=0xb75e9728) = 2617
open("/sys/block/nbd0/pid", O_RDONLY|O_LARGEFILE) = 5
read(5, "2617\n", 256)                  = 5
open("/dev/nbd0", O_RDONLY|O_LARGEFILE) = 6
exit_group(0)                           = ?



3)==========

select(11, [4 7 8 10], [], [], NULL)    = 1 (in [10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\10w\211\337\370J\2\301\0\0\0\0\177\377\0\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 673086168}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 673114055}) = 0
gettimeofday({1381947792, 257455}, NULL) = 0
rt_sigprocmask(SIG_SETMASK, ~[RTMIN RT_1], [BUS USR1 ALRM IO], 8) = 0
clone(child_stack=0xb6fb4454, 
flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID,
 parent_tidptr=0xb6fb4bd8, {entry_number:6, base_addr:0xb6fb4b70, 
limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, 
seg_not_present:0, useable:1}, child_tidptr=0xb6fb4bd8) = 2502
rt_sigprocmask(SIG_SETMASK, [BUS USR1 ALRM IO], NULL, 8) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [4 8])
read(8, "\1\0\0\0\0\0\0\0", 512)        = 8
read(4, "\0", 16)                       = 1
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\10w\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 673733305}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 673760970}) = 0
gettimeofday({1381947792, 258101}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 3 (in [4 8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\270{\211\337\370J\2\301\0\0\0\0\177\377\340\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
read(4, "\0\0", 16)                     = 2
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\270{\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 674249470}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 674276710}) = 0
gettimeofday({1381947792, 258617}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0`y\211\337\370J\2\301\0\0\0\0\177\377\360\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 674487375}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 674514971}) = 0
gettimeofday({1381947792, 258855}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0`y\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 674877957}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 674905303}) = 0
gettimeofday({1381947792, 259245}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\200|\211\337\370J\2\301\0\0\0\0\177\375\360\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\200|\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
read(8, "\4\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 675321220}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 675347583}) = 0
gettimeofday({1381947792, 259686}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0H}\211\337\370J\2\301\0\0\0\0\177\377\200\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
clock_gettime(CLOCK_MONOTONIC, {4617, 675520432}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 675547085}) = 0
gettimeofday({1381947792, 259886}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0H}\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 675900031}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 675926378}) = 0
gettimeofday({1381947792, 260265}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\20~\211\337\370J\2\301\0\0\0\0\177\376\0\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\20~\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
read(8, "\4\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 676367264}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 676393812}) = 0
gettimeofday({1381947792, 260733}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [10])
recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"address@hidden", 28}], 
msg_controllen=0, msg_flags=0}, 0) = 28
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"address@hidden", 16}], 
msg_controllen=0, msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 676774764}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 676801483}) = 0
gettimeofday({1381947792, 261140}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"address@hidden", 28}], 
msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 677012536}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 677041784}) = 0
gettimeofday({1381947792, 261394}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"address@hidden", 16}], 
msg_controllen=0, msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 677426847}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 677453322}) = 0
gettimeofday({1381947792, 261792}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\20~\211\337\370J\2\301\0\0\0\0\0\0p\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 677657510}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 677683625}) = 0
gettimeofday({1381947792, 262022}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\20~\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\7\200\0\0\7\200\1\0\7\200\2\0\7\200\3\0\7\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 678034541}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 678061142}) = 0
gettimeofday({1381947792, 262400}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0H}\211\337\370J\2\301\0\0\0\0\0\0\360\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 678258703}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 678284454}) = 0
gettimeofday({1381947792, 262623}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0H}\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\17\200\0\0\17\200\1\0\17\200\2\0\17\200\3\0\17\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 678624438}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 678650172}) = 0
gettimeofday({1381947792, 262988}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\200|\211\337\370J\2\301\0\0\0\0\0\0 
\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 678844201}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 678869874}) = 0
gettimeofday({1381947792, 263208}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\200|\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\2\200\0\0\2\200\1\0\2\200\2\0\2\200\3\0\2\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 679215880}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 679241650}) = 0
gettimeofday({1381947792, 263580}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0`y\211\337\370J\2\301\0\0\0\0\0\1\0\0\0\0\20\0", 
28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 679436097}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 679461880}) = 0
gettimeofday({1381947792, 263800}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0`y\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\20\200\0\0\20\200\1\0\20\200\2\0\20\200\3\0\20\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 679801100}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 679826444}) = 0
gettimeofday({1381947792, 264165}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\270{\211\337\370J\2\301\0\0\0\0\0\0\200\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 680026336}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 680052367}) = 0
gettimeofday({1381947792, 264391}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\270{\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\10\200\0\0\10\200\1\0\10\200\2\0\10\200\3\0\10\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 680393173}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 680419096}) = 0
gettimeofday({1381947792, 264758}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\10w\211\337\370J\2\301\0\0\0\0\0\2\0\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 680613875}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 680639741}) = 0
gettimeofday({1381947792, 264978}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\10w\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{" \200\0\0 \200\1\0 \200\2\0 
\200\3\0 \200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 4096}], msg_controllen=0, 
msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 680982582}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 681011418}) = 0
gettimeofday({1381947792, 265350}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\230x\211\337\370J\2\301\0\0\0\0\0\2\20\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 681205417}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 681230811}) = 0
gettimeofday({1381947792, 265569}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\230x\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"!\200\0\0!\200\1\0!\200\2\0!\200\3\0!\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 681568208}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 681593995}) = 0
gettimeofday({1381947792, 265932}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\320w\211\337\370J\2\301\0\0\0\0\0\2 
\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 681786255}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 681811824}) = 0
gettimeofday({1381947792, 266150}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\320w\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\"\200\0\0\"\200\1\0\"\200\2\0\"\200\3\0\"\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 682149288}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 682174762}) = 0
gettimeofday({1381947792, 266513}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\330~\211\337\370J\2\301\0\0\0\0\0\6\0\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 682367933}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 682393840}) = 0
gettimeofday({1381947792, 266732}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\330~\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"`\200\0\0`\200\1\0`\200\2\0`\200\3\0`\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 682731029}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 682756641}) = 0
gettimeofday({1381947792, 267095}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0(z\211\337\370J\2\301\0\0\0\0\0\6\20\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 682954135}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 682980023}) = 0
gettimeofday({1381947792, 267318}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0(z\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"a\200\0\0a\200\1\0a\200\2\0a\200\3\0a\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 683316790}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 683342430}) = 0
gettimeofday({1381947792, 267681}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\360z\211\337\370J\2\301\0\0\0\0\0\6 
\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 683536301}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 683562449}) = 0
gettimeofday({1381947792, 267901}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\360z\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"b\200\0\0b\200\1\0b\200\2\0b\200\3\0b\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 683900654}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 683926414}) = 0
gettimeofday({1381947792, 268265}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\360z\211\337\370J\2\301\0\0\0\0\0\4\0\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 684124398}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 684150097}) = 0
gettimeofday({1381947792, 268488}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\360z\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"@address@hidden@address@hidden@\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 684487657}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 684515496}) = 0
gettimeofday({1381947792, 268854}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0(address@hidden", 
28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 684707712}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 684736889}) = 0
gettimeofday({1381947792, 269076}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0(z\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\4\200\0\0\4\200\1\0\4\200\2\0\4\200\3\0\4\200\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 685080739}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 685106289}) = 0
gettimeofday({1381947792, 269444}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\330~\211\337\370J\2\301\0\0\0\0\0 
\0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 685299653}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 685325276}) = 0
gettimeofday({1381947792, 269663}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\330~\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 685674021}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 685699648}) = 0
gettimeofday({1381947792, 270038}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\320w\211\337\370J\2\301\0\0\0\0\0\0\0\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 685892851}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 685918482}) = 0
gettimeofday({1381947792, 270257}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\320w\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 686254784}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 686280563}) = 0
gettimeofday({1381947792, 270619}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\230x\211\337\370J\2\301\0\0\0\0\0\0\20\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 686473590}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 686499245}) = 0
gettimeofday({1381947792, 270837}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\230x\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\201\0\0\0\202\0\0\0\203\0\0\0w}\365\37\2\0\4\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 686838545}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 686864137}) = 0
gettimeofday({1381947792, 271202}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\10w\211\337\370J\2\301\0\0\0\0\0\0100\0\0\0\20\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 687057993}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 687083717}) = 0
gettimeofday({1381947792, 271422}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\10w\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0b\302^Rb\302^Rb\302^R\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 687418549}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 687444145}) = 0
gettimeofday({1381947792, 271782}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 2 (in [8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0\270{\211\337\370J\2\301\0\0\0\0@  \0\0\0\20\0", 
28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 687637477}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 687662888}) = 0
gettimeofday({1381947792, 272001}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0\270{\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"\300;address@hidden"..., 4096}], 
msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 688029898}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 688055744}) = 0
gettimeofday({1381947792, 272394}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 3 (in [4 8 10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\1`y\211\337\370J\2\301\0\0\0\0\0\0\0\0\0\0\20\0", 
28}], msg_controllen=0, msg_flags=0}, 0) = 28
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
read(4, "\0\0", 16)                     = 2
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
clock_gettime(CLOCK_MONOTONIC, {4617, 688361860}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 688387368}) = 0
gettimeofday({1381947792, 272726}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
clock_gettime(CLOCK_MONOTONIC, {4617, 690841914}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 690871850}) = 0
gettimeofday({1381947792, 275210}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
clock_gettime(CLOCK_MONOTONIC, {4617, 691285911}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 691311235}) = 0
gettimeofday({1381947792, 275649}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0`y\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 691847873}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 691874907}) = 0
gettimeofday({1381947792, 276215}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [8])
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4617, 691999716}) = 0
clock_gettime(CLOCK_MONOTONIC, {4617, 692031827}) = 0
gettimeofday({1381947792, 276374}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\0H}\211\337\370J\2\301\0\0\0\0\0(0\0\0\0\20\0", 
28}], msg_controllen=0, msg_flags=0}, 0) = 28
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
clock_gettime(CLOCK_MONOTONIC, {4619, 157057596}) = 0
clock_gettime(CLOCK_MONOTONIC, {4619, 157089969}) = 0
gettimeofday({1381947793, 741432}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [4])
read(4, "\0", 16)                       = 1
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\0\0\0\0H}\211\337\370J\2\301", 16}], msg_controllen=0, 
msg_flags=0}, 0) = 16
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\2\0\0\0\f\0\1\2.\0\0\0\2\0\0\0\f\0\2\2..\0\0\v\0\0\0\350\17\n\2"...,
 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4619, 157493390}) = 0
clock_gettime(CLOCK_MONOTONIC, {4619, 157523670}) = 0
gettimeofday({1381947793, 741870}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [8])
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4619, 157663414}) = 0
clock_gettime(CLOCK_MONOTONIC, {4619, 157693026}) = 0
gettimeofday({1381947793, 742035}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = ? ERESTARTNOHAND (To be restarted)
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\260\305\335\21\2\0\0\0H}\211\337\370J\2\301\0\0\0\0\0(0\0\2\0\0\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 0
write(2, "nbd.c:nbd_receive_request():L517"..., 46) = 46
close(10)                               = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4720, 294048012}) = 0
clock_gettime(CLOCK_MONOTONIC, {4720, 294099006}) = 0
gettimeofday({1381947917, 351168}, NULL) = 0
select(9, [4 6 7 8], [], [], NULL)      = 1 (in [8])
read(8, "\1\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4720, 294357650}) = 0
clock_gettime(CLOCK_MONOTONIC, {4720, 294390180}) = 0
gettimeofday({1381947917, 351448}, NULL) = 0
select(9, [4 6 7 8], [], [], NULL)      = 1 (in [6])
accept(6, {sa_family=AF_INET, sin_port=htons(59655), 
sin_addr=inet_addr("127.0.0.1")}, [16]) = 10
fcntl64(10, F_GETFL)                    = 0x2 (flags O_RDWR)
fcntl64(10, F_SETFL, O_RDWR)            = 0
send(10, "NBDMAGIC\0\0B\2\201\206\22S\0\0\0\0\200\0\0\0\0\0\0-\0\0\0\0"..., 
152, 0) = 152
fcntl64(10, F_GETFL)                    = 0x2 (flags O_RDWR)
fcntl64(10, F_SETFL, O_RDWR|O_NONBLOCK) = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4720, 295635776}) = 0
clock_gettime(CLOCK_MONOTONIC, {4720, 295668849}) = 0
gettimeofday({1381947917, 352737}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [8])
read(8, "\1\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4720, 295838190}) = 0
clock_gettime(CLOCK_MONOTONIC, {4720, 295866524}) = 0
gettimeofday({1381947917, 352923}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"%`\225\23\0\0\0\2$}\254\337\0\0\237\337\377\377\377\377\377\377\376\0\0\0\0\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 28
write(2, "nbd.c:nbd_trip():L836: From: 184"..., 88) = 88
write(2, "nbd.c:nbd_trip():L837: requested"..., 65) = 65
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
sendmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"gDf\230\377\377\377\352$}\254\337\0\0\237\337", 16}], 
msg_controllen=0, msg_flags=0}, 0) = 16
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4890, 325996113}) = 0
clock_gettime(CLOCK_MONOTONIC, {4890, 326026297}) = 0
gettimeofday({1381948087, 383085}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [8])
read(8, "\2\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4890, 326167801}) = 0
clock_gettime(CLOCK_MONOTONIC, {4890, 326196339}) = 0
gettimeofday({1381948087, 383254}, NULL) = 0
select(11, [4 7 8 10], [], [], NULL)    = 1 (in [10])
recvmsg(10, {msg_name(0)=NULL, 
msg_iov(1)=[{"\260\305\335\21\2\0\0\0$}\254\337\0\0\237\337\377\377\377\377\377\377\376\0\2\0\0\0",
 28}], msg_controllen=0, msg_flags=0}, 0) = 0
write(2, "nbd.c:nbd_receive_request():L517"..., 46) = 46
close(10)                               = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
clock_gettime(CLOCK_MONOTONIC, {4891, 945891719}) = 0
clock_gettime(CLOCK_MONOTONIC, {4891, 945921390}) = 0
gettimeofday({1381948089, 2979}, NULL)  = 0
select(9, [4 6 7 8], [], [], NULL)      = 1 (in [8])
read(8, "\1\0\0\0\0\0\0\0", 512)        = 8
clock_gettime(CLOCK_MONOTONIC, {4891, 946055807}) = 0
clock_gettime(CLOCK_MONOTONIC, {4891, 946084089}) = 0
gettimeofday({1381948089, 3142}, NULL)  = 0
select(9, [4 6 7 8], [], [], NULL)      = ? ERESTARTNOHAND (To be restarted)
--- SIGTERM (Terminated) @ 0 (0) ---
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
sigreturn()                             = ? (mask now [BUS USR1 ALRM IO])
clock_gettime(CLOCK_MONOTONIC, {4903, 772249684}) = 0
clock_gettime(CLOCK_MONOTONIC, {4903, 772281593}) = 0
gettimeofday({1381948100, 829342}, NULL) = 0
munmap(0xb64b3000, 1052672)             = 0
write(9, "\1\0\0\0\0\0\0\0", 8)         = 8
rt_sigprocmask(SIG_SETMASK, ~[RTMIN RT_1], [BUS USR1 ALRM IO], 8) = 0
clone(child_stack=0xb6fb4454, 
flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID,
 parent_tidptr=0xb6fb4bd8, {entry_number:6, base_addr:0xb6fb4b70, 
limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, 
seg_not_present:0, useable:1}, child_tidptr=0xb6fb4bd8) = 2632
rt_sigprocmask(SIG_SETMASK, [BUS USR1 ALRM IO], NULL, 8) = 0
select(5, [4], [], NULL, NULL)          = 1 (in [4])
read(4, "\0", 16)                       = 1
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
select(5, [4], [], NULL, NULL)          = 1 (in [4])
read(4, "\0", 16)                       = 1
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
select(5, [4], [], NULL, NULL)          = 1 (in [4])
read(4, "\0", 16)                       = 1
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
select(5, [4], [], NULL, NULL)          = 1 (in [4])
read(4, "\0", 16)                       = 1
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
select(5, [4], [], NULL, NULL)          = 1 (in [4])
read(4, "\0", 16)                       = 1
munmap(0xb65b4000, 2101248)             = 0
futex(0xb77be744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb77be740, {FUTEX_OP_SET, 0, 
FUTEX_OP_CMP_GT, 1}) = 1
select(5, [4], [], NULL, NULL)          = 1 (in [4])
read(4, "\0", 16)                       = 1
close(3)                                = 0
timer_delete(0x1)                       = 0
munmap(0xb6fb5000, 1052672)             = 0
exit_group(0)                           = ?


4)==========

Unmounting temporary filesystems...done. 'e' to edit the
Deactivating swap...done.ng, or 'c' for a command-line.
Unmounting local filesystems...[  233.985582] ------------[ cut here 
]------------
[  233.990186] kernel BUG at 
/build/buildd-linux-2.6_2.6.32-45-i386-yQfQSv/linux-2.6-2.6.32/debian/build/source!
[  234.002400] invalid opcode: 0000 [#1] SMP matically in 1 seconds.
[  234.006510] last sysfs file: /sys/devices/virtual/block/nbd0/pid
[  234.012495] Modules linked in: ext3 jbd loop snd_hda_codec_realtek 
snd_hda_intel snd_hda_codec snd_hwdep snd]
[  234.047565]
[  234.049051] Pid: 1934, comm: umount Not tainted (2.6.32-5-686 #1) CBxx55/56
[  234.055986] EIP: 0060:[<c10cdac4>] EFLAGS: 00010246 CPU: 6
[  234.061455] EIP is at submit_bh+0x17/0x106
[  234.065537] EAX: 000004c1 EBX: f6bde080 ECX: f6bde0c0 EDX: 00000005
[  234.071781] ESI: f65aa600 EDI: 000004c1 EBP: f6611800 ESP: dfbe7f24
[  234.078024]  DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[  234.083405] Process umount (pid: 1934, ti=dfbe6000 task=f66df2c0 
task.ti=dfbe6000)
[  234.090945] Stack:
[  234.092950]  f6bde080 f65aa600 f65a8000 c10cefe6 dfe04400 f65aa600 f8ae53a9 
f65a8000
[  234.100586] <0> f8aeb5fc f8aeefd0 f6611800 c10b5540 f6824600 00000003 
c10b55da f65a8000
[  234.108687] <0> c10e3e16 c10b5b77 f65a8000 f6611800 f6611818 c10c5b5b 
dfbe7f88 00000000
[  234.116981] Call Trace:
[  234.119423]  [<c10cefe6>] ? sync_dirty_buffer+0x46/0x83
[  234.124632]  [<f8ae53a9>] ? ext3_put_super+0x77/0x1b6 [ext3]
[  234.130275]  [<c10b5540>] ? generic_shutdown_super+0x46/0xc6
[  234.135915]  [<c10b55da>] ? kill_block_super+0x1a/0x2c
[  234.141038]  [<c10e3e16>] ? vfs_quota_off+0x0/0xd
[  234.145726]  [<c10b5b77>] ? deactivate_super+0x4a/0x5f
[  234.150848]  [<c10c5b5b>] ? sys_umount+0x2a5/0x2cb
[  234.155624]  [<c10030fb>] ? sysenter_do_call+0x12/0x28
[  234.160744] Code: 04 e8 36 fd ff ff 89 d8 3b 1c 24 eb ef 59 89 f0 5b 5e 5f 
c3 57 89 c7 56 53 89 d3 8b 12 f6
[  234.176165] EIP: [<c10cdac4>] submit_bh+0x17/0x106 SS:ESP 0068:dfbe7f24
[  234.176177] ---[ end trace dd7481bfd11921ae ]---
[  234.176178] ------------[ cut here ]------------
[  234.176182] WARNING: at 
/build/buildd-linux-2.6_2.6.32-45-i386-yQfQSv/linux-2.6-2.6.32/debian/build/source_i)
[  234.176184] Hardware name: CBxx55/56
[  234.176185] Modules linked in: ext3 jbd loop snd_hda_codec_realtek 
snd_hda_intel snd_hda_codec snd_hwdep snd]
[  234.176201] Pid: 1934, comm: umount Tainted: G      D    2.6.32-5-686 #1
[  234.176202] Call Trace:
[  234.176206]  [<c1030949>] ? warn_slowpath_common+0x5e/0x8a
[  234.176209]  [<c103097f>] ? warn_slowpath_null+0xa/0xc
[  234.176211]  [<c10335e0>] ? do_exit+0x30/0x5cf
[  234.176216]  [<c126d6b3>] ? printk+0xe/0x13
[  234.176218]  [<c126fc08>] ? oops_end+0x98/0x9d
[  234.176221]  [<c1004121>] ? do_invalid_op+0x0/0x75
[  234.176224]  [<c100418d>] ? do_invalid_op+0x6c/0x75
[  234.176227]  [<c10cdac4>] ? submit_bh+0x17/0x106
[  234.176230]  [<c10c96c0>] ? writeback_single_inode+0x26a/0x273
[  234.176234]  [<f8aa8599>] ? journal_destroy+0x16c/0x188 [jbd]
[  234.176237]  [<f8aa85ab>] ? journal_destroy+0x17e/0x188 [jbd]
[  234.176240]  [<f8aa85ab>] ? journal_destroy+0x17e/0x188 [jbd]
[  234.176243]  [<c10aef0b>] ? kfree+0xcc/0xde
[  234.176245]  [<c126f2f3>] ? error_code+0x73/0x78
[  234.176248]  [<c10cdac4>] ? submit_bh+0x17/0x106
[  234.176251]  [<c10cefe6>] ? sync_dirty_buffer+0x46/0x83
[  234.176255]  [<f8ae53a9>] ? ext3_put_super+0x77/0x1b6 [ext3]
[  234.176258]  [<c10b5540>] ? generic_shutdown_super+0x46/0xc6
[  234.176261]  [<c10b55da>] ? kill_block_super+0x1a/0x2c
[  234.176264]  [<c10e3e16>] ? vfs_quota_off+0x0/0xd
[  234.176267]  [<c10b5b77>] ? deactivate_super+0x4a/0x5f
[  234.176270]  [<c10c5b5b>] ? sys_umount+0x2a5/0x2cb
[  234.176272]  [<c10030fb>] ? sysenter_do_call+0x12/0x28
[  234.176274] ---[ end trace dd7481bfd11921af ]---
/etc/rc0.d/K17umountfs: line 19:  1934 Segmentation fault      fstab-decode 
umount -f -r -d $REG_MTPTS
failed.
Stopping web server: apache2.
Stopping nginx: nginx.
Stopping enhanced syslogd: rsyslogd already stopped.
Will now halt.








reply via email to

[Prev in Thread] Current Thread [Next in Thread]