qemu-devel.nongnu.org archive mirror
 help / color / mirror / Atom feed
* Re: [Qemu-devel] [Nbd]  Hibernate and qemu-nbd
  2013-09-25 14:42 [Qemu-devel] " Mark Trumpold
@ 2013-09-26 19:46 ` Wouter Verhelst
  0 siblings, 0 replies; 9+ messages in thread
From: Wouter Verhelst @ 2013-09-26 19:46 UTC (permalink / raw)
  To: Mark Trumpold
  Cc: nbd-general, Stefan Hajnoczi, bonzini, Paul Clements,
	qemu-devel@nongnu.org

On 25-09-13 16:42, Mark Trumpold wrote:
> Hello Wouter,
> 
> Thank you for your input.
> 
> I replayed the test as follows:
> 
>   -> qemu-nbd -p 2000 -persist /root/qemu/q1.img &
>   -> nbd-client localhost 2000 /dev/nbd0

No.

nbd-client -persist localhost 2000 /dev/nbd0

-- 
This end should point toward the ground if you want to go to space.

If it starts pointing toward space you are having a bad problem and you
will not go to space today.

  -- http://xkcd.com/1133/

^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: [Qemu-devel] [Nbd]  Hibernate and qemu-nbd
@ 2013-09-26 20:48 Mark Trumpold
  2013-09-27  5:18 ` Stefan Hajnoczi
  0 siblings, 1 reply; 9+ messages in thread
From: Mark Trumpold @ 2013-09-26 20:48 UTC (permalink / raw)
  To: Wouter Verhelst, Mark Trumpold
  Cc: nbd-general, Stefan Hajnoczi, bonzini, Paul Clements, qemu-devel


>-----Original Message-----
>From: Wouter Verhelst [mailto:w@uter.be]
>Sent: Thursday, September 26, 2013 12:46 PM
>To: 'Mark Trumpold'
>Cc: nbd-general@lists.sourceforge.net, 'Stefan Hajnoczi', 
>bonzini@stefanha-thinkpad.redhat.com, 'Paul Clements', qemu-devel@nongnu.org
>Subject: Re: [Nbd] [Qemu-devel] Hibernate and qemu-nbd
>
>On 25-09-13 16:42, Mark Trumpold wrote:
>> Hello Wouter,
>> 
>> Thank you for your input.
>> 
>> I replayed the test as follows:
>> 
>>   -> qemu-nbd -p 2000 -persist /root/qemu/q1.img &
>>   -> nbd-client localhost 2000 /dev/nbd0
>
>No.
>
>nbd-client -persist localhost 2000 /dev/nbd0
>
>-- 
>This end should point toward the ground if you want to go to space.
>
>If it starts pointing toward space you are having a bad problem and you
>will not go to space today.
>
>  -- http://xkcd.com/1133/
>

Sorry guys, I did the email by memory (bad idea).

Actually, what I did:
  849  qemu-nbd -p 2000 /root/qemu/q1.img &
  850  nbd-client -persist localhost 2000 /dev/nbd0
  851  ps aux | grep nbd
  852  echo reboot >/sys/power/disk
  853  echo disk >/sys/power/state

At the prompt after the hibernate (test mode: 'reboot')
I see the following:

/build/buildd-qemu_0.12.5+dfsg-3squeeze3-amd64-9wXBnc/qemu-0.12.5+dfsg/nbd.c:nbd_receive_request():L465: read failed
[1]+  Done                    qemu-nbd -p 2000 /root/qemu/q1.img

================
Looks like 'qemu-nbd' exited on some signal.  No other indicators.
I see no other relevant messages in syslog.
In dmesg I see the message (as expected):

Sep 26 13:27:13 debian-test kernel: [606754.367766] Freezing user space processes ...
Sep 26 13:27:13 debian-test kernel: [606754.367840] nbd (pid 8432: nbd-client) got signal 0
Sep 26 13:27:13 debian-test kernel: [606754.367844] block nbd0: shutting down socket
Sep 26 13:27:13 debian-test kernel: [606754.367872] block nbd0: Receive control failed (result -4)
Sep 26 13:27:13 debian-test kernel: [606754.367890] block nbd0: queue cleared

================

Thank you,
Mark T.

^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: [Qemu-devel] [Nbd]  Hibernate and qemu-nbd
  2013-09-26 20:48 [Qemu-devel] [Nbd] Hibernate and qemu-nbd Mark Trumpold
@ 2013-09-27  5:18 ` Stefan Hajnoczi
  2013-10-04 14:30   ` Mark Trumpold
  0 siblings, 1 reply; 9+ messages in thread
From: Stefan Hajnoczi @ 2013-09-27  5:18 UTC (permalink / raw)
  To: Mark Trumpold
  Cc: nbd-general, Wouter Verhelst, bonzini, Paul Clements, qemu-devel

On Thu, Sep 26, 2013 at 10:48 PM, Mark Trumpold <markt@netqa.com> wrote:
>
>>-----Original Message-----
>>From: Wouter Verhelst [mailto:w@uter.be]
>>Sent: Thursday, September 26, 2013 12:46 PM
>>To: 'Mark Trumpold'
>>Cc: nbd-general@lists.sourceforge.net, 'Stefan Hajnoczi',
>>bonzini@stefanha-thinkpad.redhat.com, 'Paul Clements', qemu-devel@nongnu.org
>>Subject: Re: [Nbd] [Qemu-devel] Hibernate and qemu-nbd
>>
>>On 25-09-13 16:42, Mark Trumpold wrote:
>>> Hello Wouter,
>>>
>>> Thank you for your input.
>>>
>>> I replayed the test as follows:
>>>
>>>   -> qemu-nbd -p 2000 -persist /root/qemu/q1.img &
>>>   -> nbd-client localhost 2000 /dev/nbd0
>>
>>No.
>>
>>nbd-client -persist localhost 2000 /dev/nbd0
>>
>>--
>>This end should point toward the ground if you want to go to space.
>>
>>If it starts pointing toward space you are having a bad problem and you
>>will not go to space today.
>>
>>  -- http://xkcd.com/1133/
>>
>
> Sorry guys, I did the email by memory (bad idea).
>
> Actually, what I did:
>   849  qemu-nbd -p 2000 /root/qemu/q1.img &

Try the qemu-nbd --persistent option.  That should prevent it from
shutting down when nbd-client is disconnected.

Stefan

^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: [Qemu-devel] [Nbd]  Hibernate and qemu-nbd
  2013-09-27  5:18 ` Stefan Hajnoczi
@ 2013-10-04 14:30   ` Mark Trumpold
  2013-10-10  9:15     ` Stefan Hajnoczi
  0 siblings, 1 reply; 9+ messages in thread
From: Mark Trumpold @ 2013-10-04 14:30 UTC (permalink / raw)
  To: Stefan Hajnoczi
  Cc: nbd-general, Wouter Verhelst, bonzini, Paul Clements,
	qemu-devel@nongnu.org



On 9/26/13 10:18 PM, "Stefan Hajnoczi" <stefanha@gmail.com> 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..

Thank you for all your attention on this.

Best Regards,
Mark T.

^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: [Qemu-devel] [Nbd]  Hibernate and qemu-nbd
  2013-10-04 14:30   ` Mark Trumpold
@ 2013-10-10  9:15     ` Stefan Hajnoczi
  2013-10-15 15:17       ` Stefan Hajnoczi
  0 siblings, 1 reply; 9+ messages in thread
From: Stefan Hajnoczi @ 2013-10-10  9:15 UTC (permalink / raw)
  To: Mark Trumpold
  Cc: nbd-general, Wouter Verhelst, bonzini, Paul Clements,
	qemu-devel@nongnu.org

On Fri, Oct 04, 2013 at 07:30:45AM -0700, Mark Trumpold wrote:
> 
> 
> On 9/26/13 10:18 PM, "Stefan Hajnoczi" <stefanha@gmail.com> 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..

Too bad.  I'm sure it's solvable but would require more debugging and
writing qemu-nbd.c and kernel nbd.c fixes.  Unfortunately I don't have
time to look into it myself.

Stefan

^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: [Qemu-devel] [Nbd]  Hibernate and qemu-nbd
  2013-10-10  9:15     ` Stefan Hajnoczi
@ 2013-10-15 15:17       ` Stefan Hajnoczi
  0 siblings, 0 replies; 9+ messages in thread
From: Stefan Hajnoczi @ 2013-10-15 15:17 UTC (permalink / raw)
  To: Mark Trumpold
  Cc: nbd-general, Wouter Verhelst, Paul Clements,
	qemu-devel@nongnu.org, Paolo Bonzini

On Thu, Oct 10, 2013 at 11:15 AM, Stefan Hajnoczi <stefanha@gmail.com> wrote:
> On Fri, Oct 04, 2013 at 07:30:45AM -0700, Mark Trumpold wrote:
>>
>>
>> On 9/26/13 10:18 PM, "Stefan Hajnoczi" <stefanha@gmail.com> 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

^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: [Qemu-devel] [Nbd]  Hibernate and qemu-nbd
@ 2013-10-17 17:07 Mark Trumpold
  2013-10-17 19:53 ` Paul Clements
  0 siblings, 1 reply; 9+ messages in thread
From: Mark Trumpold @ 2013-10-17 17:07 UTC (permalink / raw)
  To: Stefan Hajnoczi, Mark Trumpold
  Cc: nbd-general, Wouter Verhelst, Paul Clements, qemu-devel,
	Paolo Bonzini


>-----Original Message-----
>From: Stefan Hajnoczi [mailto:stefanha@gmail.com]
>Sent: Tuesday, October 15, 2013 08:17 AM
>To: 'Mark Trumpold'
>Cc: 'Wouter Verhelst', nbd-general@lists.sourceforge.net, 'Paul Clements',
>qemu-devel@nongnu.org, 'Paolo Bonzini'
>Subject: Re: [Nbd] [Qemu-devel] Hibernate and qemu-nbd
>
>On Thu, Oct 10, 2013 at 11:15 AM, Stefan Hajnoczi <stefanha@gmail.com> wrote:
>> On Fri, Oct 04, 2013 at 07:30:45AM -0700, Mark Trumpold wrote:
>>>
>>>
>>> On 9/26/13 10:18 PM, "Stefan Hajnoczi" <stefanha@gmail.com> 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)=[{"%`\225\23\0\0\0\0@v\211\337\370J\2\301\0\0\0\0\177\374\340\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@v\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, 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)=[{"%`\225\23\0\0\0\0@v\211\337\0\4\0\0\0\0\0\0\0\20\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, 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)=[{"gDf\230\0\0\0\0@v\211\337\0\4\0\0", 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)=[{"@\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, 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(z\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, 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;9\230\0\0\0\4\0\0\0\0\0\0\20\0\0\0@\0\0\0\0\1\0\0\0\5\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, 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.

^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: [Qemu-devel] [Nbd]  Hibernate and qemu-nbd
  2013-10-17 17:07 Mark Trumpold
@ 2013-10-17 19:53 ` Paul Clements
  0 siblings, 0 replies; 9+ messages in thread
From: Paul Clements @ 2013-10-17 19:53 UTC (permalink / raw)
  To: Mark Trumpold
  Cc: nbd-general@lists.sourceforge.net, Stefan Hajnoczi, Paolo Bonzini,
	qemu-devel, Wouter Verhelst

[-- Attachment #1: Type: text/plain, Size: 446 bytes --]

Hi Mark,

On Thu, Oct 17, 2013 at 1:07 PM, Mark Trumpold <markt@netqa.com> wrote:


>   165  strace -p 2488 -o /var/tmp/qemu.nbd.strace.v2 &
>   166  strace -p 2492 -o /var/tmp/nbd-client.strace.v2 &
>

You'll need to include the -f option to strace to get the full child trace
(at least for nbd-client). In the output you sent, we don't see the child
nbd-client, which is the one calling the NBD_DO_IT ioctl, which is
important to see.

--
Paul

[-- Attachment #2: Type: text/html, Size: 926 bytes --]

^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: [Qemu-devel] [Nbd]  Hibernate and qemu-nbd
@ 2013-10-18 18:23 Mark Trumpold
  0 siblings, 0 replies; 9+ messages in thread
From: Mark Trumpold @ 2013-10-18 18:23 UTC (permalink / raw)
  To: Paul Clements, Mark Trumpold
  Cc: nbd-general, Stefan Hajnoczi, Paolo Bonzini, qemu-devel,
	Wouter Verhelst


>-----Original Message-----
>From: Paul Clements [mailto:paul.clements@us.sios.com]
>Sent: Thursday, October 17, 2013 12:53 PM
>To: 'Mark Trumpold'
>Cc: 'Stefan Hajnoczi', nbd-general@lists.sourceforge.net, 'Wouter Verhelst',
>qemu-devel@nongnu.org, 'Paolo Bonzini'
>Subject: Re: [Nbd] [Qemu-devel] Hibernate and qemu-nbd
>
>Hi Mark,
>
>On Thu, Oct 17, 2013 at 1:07 PM, Mark Trumpold <markt@netqa.com> wrote:
>
>
>>   165  strace -p 2488 -o /var/tmp/qemu.nbd.strace.v2 &
>>   166  strace -p 2492 -o /var/tmp/nbd-client.strace.v2 &
>>
>
>You'll need to include the -f option to strace to get the full child trace
>(at least for nbd-client). In the output you sent, we don't see the child
>nbd-client, which is the one calling the NBD_DO_IT ioctl, which is
>important to see.
>
>--
>Paul
>


Hi all,

I re-ran the test with Paul's suggestion.  For brevity I just include this latest test run.  This time with the actual terminal output where the test was executed, since it contains PIDs, etc -- though a bit harder to read:

1) Test scenario (actual terminal screen).
2) strace from nbd-client
3) strace from qemu-nbd (quite lengthy -- 1539 lines)
4) kernel oops output when I 'halt' after the test scenario.

Thank you,
Mark T.


1)----------

[root@base:~] FACTORY # qemu-nbd --persistent -p 2000 /root/qemu/q1.img &
[1] 1673
[root@base:~] FACTORY # nbd-client -persist localhost 2000 /dev/nbd0
Negotiation: ..size = 2097152KB
bs=1024, sz=2097152
[root@base:~] FACTORY # pn nbd

USER       PID %CPU %MEM    VSZ   RSS TTY      STAT START   TIME COMMAND
root      1673  0.0  0.1  21296  6584 pts/0    Sl   17:39   0:00 qemu-nbd --persistent -p 2000 /root/qemu/q1.img
root      1677  0.0  0.0   1724   116 ?        S    17:39   0:00 nbd-client -persist localhost 2000 /dev/nbd0
root      1678  0.0  0.0      0     0 ?        S<   17:39   0:00 [nbd0]

[root@base:~] FACTORY # ls /var/tmp
cimserver_start.lock  root-loop
[root@base:~] FACTORY # strace -f -p 1673 -o /var/tmp/qemu.nbd.strace.v3 &
[2] 1687
[root@base:~] FACTORY # Process 1673 attached - interrupt to quit

[root@base:~] FACTORY # strace -f -p 1677 -o /var/tmp/nbd-client.strace.v3 &
[3] 1696
[root@base:~] FACTORY # Process 1677 attached - interrupt to quit

[root@base:~] FACTORY # mount /dev/nbd0 /mnt
Process 1698 attached (waiting for parent)
Process 1698 resumed (parent 1673 ready)
[root@base:~] FACTORY # Process 1698 detached

[root@base:~] FACTORY # ls /mnt
Process 1703 attached (waiting for parent)
Process 1703 resumed (parent 1673 ready)
lost+found
[root@base:~] FACTORY # echo reboot >/sys/power/disk
[root@base:~] FACTORY # echo disk >/sys/power/state
nbd.c:nbd_receive_request():L517: read failed
Process 1703 detached
Process 1813 attached
[root@base:~] FACTORY # Process 1677 detached

[root@base:~] FACTORY # ls /mnt


2)----------

1677  write(2, "Kernel call returned: Interrupte"..., 45) = 45
1677  write(2, " Reconnecting\n", 14)   = 14
1677  close(4)                          = 0
1677  close(3)                          = 0
1677  socket(PF_NETLINK, SOCK_RAW, 0)   = 3
1677  bind(3, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 0
1677  getsockname(3, {sa_family=AF_NETLINK, pid=1677, groups=00000000}, [12]) = 0
1677  time(NULL)                        = 1382118599
1677  sendto(3, "\24\0\0\0\26\0\1\3\307taR\0\0\0\0\0\0\0\0", 20, 0, {sa_family=AF_NETLINK, pid=0, groups=00000000}, 12) = 20
1677  recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"0\0\0\0\24\0\2\0\307taR\215\6\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
1677  recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"@\0\0\0\24\0\2\0\307taR\215\6\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
1677  recvmsg(3, {msg_name(12)={sa_family=AF_NETLINK, pid=0, groups=00000000}, msg_iov(1)=[{"\24\0\0\0\3\0\2\0\307taR\215\6\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
1677  close(3)                          = 0
1677  stat64("/etc/resolv.conf", {st_mode=S_IFREG|0644, st_size=82, ...}) = 0
1677  open("/etc/resolv.conf", O_RDONLY) = 3
1677  fstat64(3, {st_mode=S_IFREG|0644, st_size=82, ...}) = 0
1677  mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7736000
1677  read(3, "domain dvt.tachyon.net\nsearch dv"..., 4096) = 82
1677  read(3, "", 4096)                 = 0
1677  close(3)                          = 0
1677  munmap(0xb7736000, 4096)          = 0
1677  open("/etc/hosts", O_RDONLY|O_CLOEXEC) = 3
1677  fstat64(3, {st_mode=S_IFREG|0644, st_size=220, ...}) = 0
1677  mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb7736000
1677  read(3, "127.0.0.1  localhost\n127.0.1.1  "..., 4096) = 220
1677  read(3, "", 4096)                 = 0
1677  close(3)                          = 0
1677  munmap(0xb7736000, 4096)          = 0
1677  socket(PF_INET, SOCK_STREAM, IPPROTO_TCP) = 3
1677  connect(3, {sa_family=AF_INET, sin_port=htons(2000), sin_addr=inet_addr("127.0.0.1")}, 16) = 0
1677  setsockopt(3, SOL_TCP, TCP_NODELAY, [1], 4) = 0
1677  open("/dev/nbd0", O_RDWR|O_LARGEFILE) = 4
1677  write(1, "Negotiation: ", 13)     = 13
1677  read(3, "NBDMAGIC", 8)            = 8
1677  write(1, ".", 1)                  = 1
1677  read(3, "\0\0B\2\201\206\22S", 8) = 8
1677  write(1, ".", 1)                  = 1
1677  read(3, "\0\0\0\0\200\0\0\0", 8)  = 8
1677  write(1, "size = 2097152KB", 16)  = 16
1677  read(3, "\0\0\0-", 4)             = 4
1677  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
1677  write(1, "\n", 1)                 = 1
1677  ioctl(4, NBD_SET_BLKSIZE, 0x400)  = 0
1677  ioctl(4, NBD_SET_SIZE_BLOCKS, 0x200000) = 0
1677  write(2, "bs=1024, sz=2097152\n", 20) = 20
1677  ioctl(4, NBD_CLEAR_SOCK, 0x400)   = 0
1677  ioctl(4, BLKROSET, 0xbf975cec)    = 0
1677  ioctl(4, NBD_SET_SOCK, 0x3)       = 0
1677  clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0xb75eb728) = 1813
1677  open("/sys/block/nbd0/pid", O_RDONLY|O_LARGEFILE <unfinished ...>
1813  ioctl(4, NBD_DO_IT <unfinished ...>
1677  <... open resumed> )              = -1 ENOENT (No such file or directory)
1677  rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
1677  rt_sigaction(SIGCHLD, NULL, {SIG_DFL, [], 0}, 8) = 0
1677  rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
1677  nanosleep({1, 0}, 0xbf975cf4)     = 0
1677  open("/sys/block/nbd0/pid", O_RDONLY|O_LARGEFILE) = 5
1677  read(5, "1813\n", 256)            = 5
1677  open("/dev/nbd0", O_RDONLY|O_LARGEFILE) = 6
1677  exit_group(0)                     = ?


3)----------

1673  select(11, [4 7 8 10], [], [], NULL) = 1 (in [10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\360z\321\366\370J\2\301\0\0\0\0\177\377\0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 609124753}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 609155482}) = 0
1673  gettimeofday({1382118538, 708643}, NULL) = 0
1673  rt_sigprocmask(SIG_SETMASK, ~[RTMIN RT_1], [BUS USR1 ALRM IO], 8) = 0
1673  clone(child_stack=0xb6f47454, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, parent_tidptr=0xb6f47bd8, {entry_number:6, base_addr:0xb6f47b70, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}, child_tidptr=0xb6f47bd8) = 1698
1698  set_robust_list(0xb6f47be0, 0xc <unfinished ...>
1673  rt_sigprocmask(SIG_SETMASK, [BUS USR1 ALRM IO],  <unfinished ...>
1698  <... set_robust_list resumed> )   = 0
1673  <... rt_sigprocmask resumed> NULL, 8) = 0
1698  gettimeofday( <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 708840}, NULL) = 0
1673  <... select resumed> )            = 1 (in [8])
1698  pread64(3,  <unfinished ...>
1673  read(8, "\1\0\0\0\0\0\0\0", 512)  = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 609478841}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 609507770}) = 0
1673  gettimeofday({1382118538, 708994}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\200\0\0\0\5\237\0\0\200\0\0\0\5\240\0\0\200\0\0\0\5\253\0\0\200\0\0\0\5\241\0\0"..., 65536, 94240768) = 65536
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 711446}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 711503514}) = 0
1698  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1) = 1
1673  <... futex resumed> )             = 0
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 19, {9, 288496486} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1516, 612207516}) = 0
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 612262557}) = 0
1673  gettimeofday({1382118538, 711753}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\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, 102825984) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 712074}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 712125051}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 21, {9, 287874949} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\360z\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 612988043}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 613049497}) = 0
1673  gettimeofday({1382118538, 712539}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\200|\321\366\370J\2\301\0\0\0\0\177\377\340\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 613328197}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 613359300}) = 0
1673  gettimeofday({1382118538, 712845}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\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, 102883328) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 713026}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 713074996}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 23, {9, 286925004} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\200|\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 613902548}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 613930803}) = 0
1673  gettimeofday({1382118538, 713416}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0H}\321\366\370J\2\301\0\0\0\0\177\377\360\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 614211515}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 614242759}) = 0
1673  gettimeofday({1382118538, 713729}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\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, 102887424) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 713902}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 713950313}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 25, {9, 286049687} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0H}\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 614783154}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 614811114}) = 0
1673  gettimeofday({1382118538, 714296}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\330~\321\366\370J\2\301\0\0\0\0\177\375\360\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\330~\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  read(8, "\4\0\0\0\0\0\0\0", 512)  = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 615248351}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 615276457}) = 0
1673  gettimeofday({1382118538, 714762}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 1 (in [10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\330~\321\366\370J\2\301\0\0\0\0\177\377\200\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1516, 615484472}) = 0
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 615536955}) = 0
1673  gettimeofday({1382118538, 715025}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\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, 102858752) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 715233}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 715281979}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 27, {9, 284718021} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\330~\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 616111415}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 616139589}) = 0
1673  gettimeofday({1382118538, 715625}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0H}\321\366\370J\2\301\0\0\0\0\177\376\0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0H}\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  read(8, "\4\0\0\0\0\0\0\0", 512)  = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 616578964}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 616606960}) = 0
1673  gettimeofday({1382118538, 716092}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 1 (in [10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\200|\321\366\370J\2\301\0\0\0\0\177\374\340\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\200|\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 617010052}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 617038695}) = 0
1673  gettimeofday({1382118538, 716524}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\360z\321\366\370J\2\301\0\0\0\0\0\20\0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 617305327}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 617336444}) = 0
1673  gettimeofday({1382118538, 716823}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\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, 1310720) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 717178}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 717226474}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 29, {9, 282773526} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\360z\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 618050439}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 618078391}) = 0
1673  gettimeofday({1382118538, 717564}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\20~\321\366\370J\2\301\0\0\0\0\0\0p\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... pread64 resumed> "\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, 356352) = 4096
1673  <... clock_gettime resumed> {1516, 618340900}) = 0
1698  write(5, "\0", 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... write resumed> )             = 1
1673  <... clock_gettime resumed> {1516, 618401331}) = 0
1698  gettimeofday( <unfinished ...>
1673  gettimeofday( <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 717892}, NULL) = 0
1673  <... gettimeofday resumed> {1382118538, 717903}, NULL) = 0
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 717938963}) = 0
1673  <... select resumed> )            = 1 (in [4])
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 31, {9, 282061037} <unfinished ...>
1673  read(4, "\0", 16)                 = 1
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\20~\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 618836823}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 618865007}) = 0
1673  gettimeofday({1382118538, 718351}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\270{\321\366\370J\2\301\0\0\0\0\0\0\360\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 619128823}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 619159842}) = 0
1673  gettimeofday({1382118538, 718645}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\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, 389120) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 718836}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 718883806}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 33, {9, 281116194} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\270{\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 619707204}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 619739978}) = 0
1673  gettimeofday({1382118538, 719225}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\230x\321\366\370J\2\301\0\0\0\0\0\0 \0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... pread64 resumed> "\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, 335872) = 4096
1673  <... clock_gettime resumed> {1516, 619997177}) = 0
1698  write(5, "\0", 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... write resumed> )             = 1
1673  <... clock_gettime resumed> {1516, 620061250}) = 0
1698  gettimeofday( <unfinished ...>
1673  gettimeofday( <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 719553}, NULL) = 0
1673  <... gettimeofday resumed> {1382118538, 719563}, NULL) = 0
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 719599100}) = 0
1673  <... select resumed> )            = 1 (in [4])
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 35, {9, 280400900} <unfinished ...>
1673  read(4, "\0", 16)                 = 1
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\230x\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 620500302}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 620528369}) = 0
1673  gettimeofday({1382118538, 720014}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0(z\321\366\370J\2\301\0\0\0\0\0\1\0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 620787785}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 620823835}) = 0
1673  gettimeofday({1382118538, 720310}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\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, 393216) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 720618}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 720666745}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 37, {9, 279333255} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0(z\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 621523753}) = 0
1673  gettimeofday({1382118538, 721009}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\320w\321\366\370J\2\301\0\0\0\0\0\0\200\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... pread64 resumed> "\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, 360448) = 4096
1673  <... clock_gettime resumed> {1516, 621781496}) = 0
1698  write(5, "\0", 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... write resumed> )             = 1
1673  <... clock_gettime resumed> {1516, 621842315}) = 0
1698  gettimeofday( <unfinished ...>
1673  gettimeofday( <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 721333}, NULL) = 0
1673  <... gettimeofday resumed> {1382118538, 721343}, NULL) = 0
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 721379299}) = 0
1673  <... select resumed> )            = 1 (in [4])
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 39, {9, 278620701} <unfinished ...>
1673  read(4, "\0", 16)                 = 1
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\320w\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 622277834}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 622306397}) = 0
1673  gettimeofday({1382118538, 721792}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\260t\321\366\370J\2\301\0\0\0\0\0\2\0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 622569348}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 622600236}) = 0
1673  gettimeofday({1382118538, 722086}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> " \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, 1114112) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 722290}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 722343718}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 41, {9, 277656282} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\260t\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 623167557}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 623195907}) = 0
1673  gettimeofday({1382118538, 722682}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\350s\321\366\370J\2\301\0\0\0\0\0\2\20\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 623461882}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 623492724}) = 0
1673  gettimeofday({1382118538, 722979}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "!\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, 1118208) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 723113}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 723161197}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 43, {9, 276838803} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\350s\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 623982905}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 624016075}) = 0
1673  gettimeofday({1382118538, 723502}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0@v\321\366\370J\2\301\0\0\0\0\0\2 \0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... pread64 resumed> "\"\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, 1122304) = 4096
1673  <... clock_gettime resumed> {1516, 624286340}) = 0
1698  write(5, "\0", 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... write resumed> )             = 1
1673  <... clock_gettime resumed> {1516, 624355581}) = 0
1698  gettimeofday( <unfinished ...>
1673  gettimeofday( <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 723846}, NULL) = 0
1673  <... gettimeofday resumed> {1382118538, 723856}, NULL) = 0
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 723893169}) = 0
1673  <... select resumed> )            = 1 (in [4])
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 45, {9, 276106831} <unfinished ...>
1673  read(4, "\0", 16)                 = 1
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0@v\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 624798169}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 624826115}) = 0
1673  gettimeofday({1382118538, 724312}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\10w\321\366\370J\2\301\0\0\0\0\0\6\0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 625092126}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 625122650}) = 0
1673  gettimeofday({1382118538, 724608}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "`\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, 1245184) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 724786}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 724835065}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 47, {9, 275164935} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\10w\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 625662770}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 625690665}) = 0
1673  gettimeofday({1382118538, 725176}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0`y\321\366\370J\2\301\0\0\0\0\0\6\20\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 625960522}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 625991446}) = 0
1673  gettimeofday({1382118538, 725478}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "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, 1249280) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 725657}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 725705005}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 49, {9, 274294995} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0`y\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 626530977}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 626559013}) = 0
1673  gettimeofday({1382118538, 726045}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0 s\321\366\370J\2\301\0\0\0\0\0\6 \0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... pread64 resumed> "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, 1253376) = 4096
1673  <... clock_gettime resumed> {1516, 626828419}) = 0
1698  write(5, "\0", 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... write resumed> )             = 1
1673  <... clock_gettime resumed> {1516, 626892192}) = 0
1698  gettimeofday( <unfinished ...>
1673  gettimeofday( <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 726384}, NULL) = 0
1673  <... gettimeofday resumed> {1382118538, 726394}, NULL) = 0
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 726430095}) = 0
1673  <... select resumed> )            = 1 (in [4])
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 51, {9, 273569905} <unfinished ...>
1673  read(4, "\0", 16)                 = 1
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0 s\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 627334733}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 627367654}) = 0
1673  gettimeofday({1382118538, 726854}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0xu\321\366\370J\2\301\0\0\0\0\0\4\0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 627634315}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 627665227}) = 0
1673  gettimeofday({1382118538, 727151}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "@\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, 524288) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 727373}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 727421056}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 53, {9, 272578944} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0xu\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 628250769}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 628278814}) = 0
1673  gettimeofday({1382118538, 727764}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0xu\321\366\370J\2\301\0\0\0\0\0\0@\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 628544259}) = 0
1698  <... pread64 resumed> "\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, 344064) = 4096
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  write(5, "\0", 1 <unfinished ...>
1673  <... clock_gettime resumed> {1516, 628599889}) = 0
1698  <... write resumed> )             = 1
1673  gettimeofday( <unfinished ...>
1698  gettimeofday( <unfinished ...>
1673  <... gettimeofday resumed> {1382118538, 728108}, NULL) = 0
1698  <... gettimeofday resumed> {1382118538, 728118}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  <... select resumed> )            = 1 (in [4])
1698  <... clock_gettime resumed> {1382118538, 728171757}) = 0
1673  read(4,  <unfinished ...>
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 55, {9, 271828243} <unfinished ...>
1673  <... read resumed> "\0", 16)      = 1
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0xu\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 629061326}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 629089746}) = 0
1673  gettimeofday({1382118538, 728576}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0 s\321\366\370J\2\301\0\0\0\0\0 \0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 629353298}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 629383854}) = 0
1673  gettimeofday({1382118538, 728870}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\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, 2752512) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 729044}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 729091385}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 57, {9, 270908615} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0 s\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 629923669}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 629951322}) = 0
1673  gettimeofday({1382118538, 729436}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0`y\321\366\370J\2\301\0\0\0\0\0\0\0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... pread64 resumed> "\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, 327680) = 4096
1673  <... clock_gettime resumed> {1516, 630205847}) = 0
1698  write(5, "\0", 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... write resumed> )             = 1
1673  <... clock_gettime resumed> {1516, 630266159}) = 0
1698  gettimeofday( <unfinished ...>
1673  gettimeofday( <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 729757}, NULL) = 0
1673  <... gettimeofday resumed> {1382118538, 729767}, NULL) = 0
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 729803412}) = 0
1673  <... select resumed> )            = 1 (in [4])
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 59, {9, 270196588} <unfinished ...>
1673  read(4, "\0", 16)                 = 1
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0`y\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 630703354}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 630730984}) = 0
1673  gettimeofday({1382118538, 730216}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\10w\321\366\370J\2\301\0\0\0\0\0\0\20\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... pread64 resumed> "\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, 331776) = 4096
1673  <... clock_gettime resumed> {1516, 630984257}) = 0
1698  write(5, "\0", 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... write resumed> )             = 1
1673  <... clock_gettime resumed> {1516, 631042450}) = 0
1698  gettimeofday( <unfinished ...>
1673  gettimeofday( <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 730531}, NULL) = 0
1673  <... gettimeofday resumed> {1382118538, 730540}, NULL) = 0
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 730574637}) = 0
1673  <... select resumed> )            = 1 (in [4])
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 61, {9, 269425363} <unfinished ...>
1673  read(4, "\0", 16)                 = 1
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\10w\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 631462492}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 631490022}) = 0
1673  gettimeofday({1382118538, 730975}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0@v\321\366\370J\2\301\0\0\0\0\0\0100\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 631750171}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 631780718}) = 0
1673  gettimeofday({1382118538, 731266}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\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, 733184) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 731500}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 731546829}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 63, {9, 268453171} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0@v\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 632361112}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 632388374}) = 0
1673  gettimeofday({1382118538, 731873}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\350s\321\366\370J\2\301\0\0\0\0@  \0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 632642793}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 632675696}) = 0
1673  gettimeofday({1382118538, 732161}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\200\0\0\0\1\25\0\0\200\0\0\0\1\26\0\0\200\0\0\0\1\31\0\0\200\0\0\0\1\32\0\0"..., 65536, 18087936) = 65536
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 732555}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 732603005}) = 0
1698  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1) = 1
1673  <... futex resumed> )             = 0
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 65, {9, 267396995} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1516, 633278678}) = 0
1698  pread64(3,  <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 633326588}) = 0
1673  gettimeofday({1382118538, 732814}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... pread64 resumed> "\300;9\230\0\0\0\4\0\0\0\0\0\0\20\0\0\0@\0\0\0\0\1\0\0\0\5\0\0\0\0"..., 4096, 20586496) = 4096
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 733066}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 733117418}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 67, {9, 266882582} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\350s\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"\300;9\230\0\0\0\4\0\0\0\0\0\0\20\0\0\0@\0\0\0\0\1\0\0\0\5\0\0\0\0"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 633932259}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 633959530}) = 0
1673  gettimeofday({1382118538, 733444}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\1\260t\321\366\370J\2\301\0\0\0\0\0\0\0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  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
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1698  pwrite64(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"..., 4096, 327680 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 634282454}) = 0
1698  <... pwrite64 resumed> )          = 4096
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  write(5, "\0", 1 <unfinished ...>
1673  <... clock_gettime resumed> {1516, 634318827}) = 0
1698  <... write resumed> )             = 1
1673  gettimeofday( <unfinished ...>
1698  gettimeofday( <unfinished ...>
1673  <... gettimeofday resumed> {1382118538, 733823}, NULL) = 0
1698  <... gettimeofday resumed> {1382118538, 733832}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  <... select resumed> )            = 1 (in [4])
1698  <... clock_gettime resumed> {1382118538, 733884274}) = 0
1673  read(4,  <unfinished ...>
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 69, {9, 266115726} <unfinished ...>
1673  <... read resumed> "\0", 16)      = 1
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1516, 634558694}) = 0
1698  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 634602018}) = 0
1673  gettimeofday({1382118538, 734095}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... fdatasync resumed> )         = 0
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 734284}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 734330383}) = 0
1698  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1) = 1
1673  <... futex resumed> )             = 0
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 71, {9, 265669617} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1516, 635010544}) = 0
1698  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 635053317}) = 0
1673  gettimeofday({1382118538, 734539}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... fdatasync resumed> )         = 0
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 734654}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 734700776}) = 0
1698  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1) = 1
1673  <... futex resumed> )             = 0
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 73, {9, 265299224} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1698  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1698  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1516, 635374794}) = 0
1698  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 635417088}) = 0
1673  gettimeofday({1382118538, 734903}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... fdatasync resumed> )         = 0
1698  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1698  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1698  <... gettimeofday resumed> {1382118538, 735068}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1698  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1698  <... clock_gettime resumed> {1382118538, 735114919}) = 0
1673  <... write resumed> )             = 8
1698  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 75, {9, 264885081} <unfinished ...>
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\260t\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 635809776}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 635837370}) = 0
1673  gettimeofday({1382118538, 735322}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 1 (in [8])
1673  read(8, "\2\0\0\0\0\0\0\0", 512)  = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 635962760}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1516, 635989820}) = 0
1673  gettimeofday({1382118538, 735479}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1698  <... futex resumed> )             = -1 ETIMEDOUT (Connection timed out)
1698  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1) = 0
1698  madvise(0xb6748000, 8368128, MADV_DONTNEED) = 0
1698  _exit(0)                          = ?
1673  <... select resumed> )            = 1 (in [10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\0\320w\321\366\370J\2\301\0\0\0\0\0(0\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1532, 353078732}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1532, 353108088}) = 0
1673  gettimeofday({1382118554, 452594}, NULL) = 0
1673  rt_sigprocmask(SIG_SETMASK, ~[RTMIN RT_1], [BUS USR1 ALRM IO], 8) = 0
1673  clone(child_stack=0xb6f47454, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID, parent_tidptr=0xb6f47bd8, {entry_number:6, base_addr:0xb6f47b70, limit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}, child_tidptr=0xb6f47bd8) = 1703
1703  set_robust_list(0xb6f47be0, 0xc <unfinished ...>
1673  rt_sigprocmask(SIG_SETMASK, [BUS USR1 ALRM IO],  <unfinished ...>
1703  <... set_robust_list resumed> )   = 0
1673  <... rt_sigprocmask resumed> NULL, 8) = 0
1703  gettimeofday( <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... gettimeofday resumed> {1382118554, 452774}, NULL) = 0
1673  <... select resumed> )            = 1 (in [8])
1703  pread64(3,  <unfinished ...>
1673  read(8, "\1\0\0\0\0\0\0\0", 512)  = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1532, 353408787}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1532, 353437306}) = 0
1673  gettimeofday({1382118554, 452923}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... pread64 resumed> "\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, 2895872) = 4096
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118554, 455314}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1703  <... clock_gettime resumed> {1382118554, 455365018}) = 0
1673  <... write resumed> )             = 8
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 77, {9, 544634982} <unfinished ...>
1673  setsockopt(10, SOL_TCP, TCP_CORK, [1], 4) = 0
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\320w\321\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  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
1673  setsockopt(10, SOL_TCP, TCP_CORK, [0], 4) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1532, 356226846}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1532, 356258046}) = 0
1673  gettimeofday({1382118554, 455750}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 1 (in [8])
1673  read(8, "\2\0\0\0\0\0\0\0", 512)  = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1532, 356401656}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1532, 356432297}) = 0
1673  gettimeofday({1382118554, 455920}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 1 (in [10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\1 c\215\337\370J\2\301\0\0\0\0@  \0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"\300;9\230\0\0\0\4\0\0\0\0\0\0\20\0\0\0@\0\0\0\0\1\0\0\0\6\0\0\0\1"..., 4096}], msg_controllen=0, msg_flags=0}, 0) = 4096
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1537, 942256838}) = 0
1703  pwrite64(3, "\300;9\230\0\0\0\4\0\0\0\0\0\0\20\0\0\0@\0\0\0\0\1\0\0\0\6\0\0\0\1"..., 4096, 20586496 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... pwrite64 resumed> )          = 4096
1673  <... clock_gettime resumed> {1537, 942322864}) = 0
1703  write(5, "\0", 1 <unfinished ...>
1673  gettimeofday( <unfinished ...>
1703  <... write resumed> )             = 1
1673  <... gettimeofday resumed> {1382118560, 41847}, NULL) = 0
1703  gettimeofday( <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 41880}, NULL) = 0
1673  <... select resumed> )            = 1 (in [4])
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 41940277}) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 79, {9, 958059723} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1537, 942605949}) = 0
1703  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 942664639}) = 0
1673  gettimeofday({1382118560, 42158}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... fdatasync resumed> )         = 0
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 43841}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 43892504}) = 0
1703  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1) = 1
1673  <... futex resumed> )             = 0
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 81, {9, 956107496} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1537, 944579954}) = 0
1703  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 944624598}) = 0
1673  gettimeofday({1382118560, 44112}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... fdatasync resumed> )         = 0
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 44268}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 44319981}) = 0
1703  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1) = 1
1673  <... futex resumed> )             = 0
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 83, {9, 955680019} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1537, 945019331}) = 0
1703  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 945065022}) = 0
1673  gettimeofday({1382118560, 44552}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... fdatasync resumed> )         = 0
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 44704}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 44755763}) = 0
1673  <... write resumed> )             = 8
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 85, {9, 955244237} <unfinished ...>
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0 c\215\337\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 945477402}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 945508623}) = 0
1673  gettimeofday({1382118560, 44997}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\1Xb\215\337\370J\2\301\0\0\0\0@ 0\0\0\0 \0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"\300;9\230\0\0\0\1\0\0\0\6\0\0\0\203\0\0\0\10\0\0\0\0\0\0\0\0\0\0\0\0"..., 8192}], msg_controllen=0, msg_flags=0}, 0) = 8192
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1703  pwrite64(3, "\300;9\230\0\0\0\1\0\0\0\6\0\0\0\203\0\0\0\10\0\0\0\0\0\0\0\0\0\0\0\0"..., 8192, 20590592 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... pwrite64 resumed> )          = 8192
1673  <... clock_gettime resumed> {1537, 945862755}) = 0
1703  write(5, "\0", 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... write resumed> )             = 1
1673  <... clock_gettime resumed> {1537, 945916350}) = 0
1703  gettimeofday( <unfinished ...>
1673  gettimeofday( <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 45408}, NULL) = 0
1673  <... gettimeofday resumed> {1382118560, 45418}, NULL) = 0
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 45454066}) = 0
1673  <... select resumed> )            = 1 (in [4])
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 87, {9, 954545934} <unfinished ...>
1673  read(4, "\0", 16)                 = 1
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1}) = 1
1703  <... futex resumed> )             = 0
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  <... clock_gettime resumed> {1537, 946143769}) = 0
1703  <... futex resumed> )             = 0
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  fdatasync(3 <unfinished ...>
1673  <... clock_gettime resumed> {1537, 946189300}) = 0
1673  gettimeofday({1382118560, 45699}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... fdatasync resumed> )         = 0
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 46068}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 46121106}) = 0
1703  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1) = 1
1673  <... futex resumed> )             = 0
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 89, {9, 953878894} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1537, 946803542}) = 0
1703  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 946852298}) = 0
1673  gettimeofday({1382118560, 46343}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... fdatasync resumed> )         = 0
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 46538}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 46586507}) = 0
1703  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1) = 1
1673  <... futex resumed> )             = 0
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 91, {9, 953413493} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1537, 947270203}) = 0
1703  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 947314703}) = 0
1673  gettimeofday({1382118560, 46804}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... fdatasync resumed> )         = 0
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 47009}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 47057311}) = 0
1673  <... write resumed> )             = 8
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 93, {9, 952942689} <unfinished ...>
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0Xb\215\337\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 947762233}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 947792155}) = 0
1673  gettimeofday({1382118560, 47279}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 2 (in [8 10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\1\220a\215\337\370J\2\301\0\0\0\0@ P\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"\300;9\230\0\0\0\2\0\0\0\6\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
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  read(8,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... read resumed> "\2\0\0\0\0\0\0\0", 512) = 8
1703  pwrite64(3, "\300;9\230\0\0\0\2\0\0\0\6\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 4096, 20598784 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... pwrite64 resumed> )          = 4096
1673  <... clock_gettime resumed> {1537, 948137321}) = 0
1703  write(5, "\0", 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... write resumed> )             = 1
1673  <... clock_gettime resumed> {1537, 948186367}) = 0
1703  gettimeofday( <unfinished ...>
1673  gettimeofday( <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 47678}, NULL) = 0
1673  <... gettimeofday resumed> {1382118560, 47688}, NULL) = 0
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 47730109}) = 0
1673  <... select resumed> )            = 1 (in [4])
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 95, {9, 952269891} <unfinished ...>
1673  read(4, "\0", 16)                 = 1
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1537, 948437580}) = 0
1703  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 948481125}) = 0
1673  gettimeofday({1382118560, 47974}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... fdatasync resumed> )         = 0
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 48172}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 48219375}) = 0
1703  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1) = 1
1673  <... futex resumed> )             = 0
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 97, {9, 951780625} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1537, 948894930}) = 0
1703  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 948937894}) = 0
1673  gettimeofday({1382118560, 48428}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... fdatasync resumed> )         = 0
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 48582}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 48634891}) = 0
1703  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1) = 1
1673  <... futex resumed> )             = 0
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 99, {9, 951365109} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1537, 949316242}) = 0
1703  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 949359673}) = 0
1673  gettimeofday({1382118560, 48851}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... fdatasync resumed> )         = 0
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118560, 49014}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1703  <... clock_gettime resumed> {1382118560, 49062747}) = 0
1673  <... write resumed> )             = 8
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 101, {9, 950937253} <unfinished ...>
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\220a\215\337\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 949771378}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 949801869}) = 0
1673  gettimeofday({1382118560, 49290}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 1 (in [8])
1673  read(8, "\2\0\0\0\0\0\0\0", 512)  = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 949938023}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1537, 949968127}) = 0
1673  gettimeofday({1382118560, 49456}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 1 (in [10])
1673  recvmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"%`\225\23\0\0\0\1\310\260t\366\370J\2\301\0\0\0\0\0\0100\0\0\0\20\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 28
1673  recvmsg(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
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... futex resumed> )             = 1
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1547, 284290284}) = 0
1703  pwrite64(3, "\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, 733184 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... pwrite64 resumed> )          = 4096
1673  <... clock_gettime resumed> {1547, 284358591}) = 0
1703  write(5, "\0", 1 <unfinished ...>
1673  gettimeofday( <unfinished ...>
1703  <... write resumed> )             = 1
1673  <... gettimeofday resumed> {1382118569, 383878}, NULL) = 0
1703  gettimeofday( <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... gettimeofday resumed> {1382118569, 383915}, NULL) = 0
1673  <... select resumed> )            = 1 (in [4])
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... clock_gettime resumed> {1382118569, 383976946}) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 103, {9, 616023054} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1547, 284645398}) = 0
1703  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1547, 284693401}) = 0
1673  gettimeofday({1382118569, 384193}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... fdatasync resumed> )         = 0
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118569, 384387}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1703  <... clock_gettime resumed> {1382118569, 384441254}) = 0
1703  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1) = 1
1673  <... futex resumed> )             = 0
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 105, {9, 615558746} <unfinished ...>
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  <... futex resumed> )             = 0
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  <... futex resumed> )             = 0
1673  <... clock_gettime resumed> {1547, 285151564}) = 0
1703  fdatasync(3 <unfinished ...>
1673  clock_gettime(CLOCK_MONOTONIC, {1547, 285198125}) = 0
1703  <... fdatasync resumed> )         = 0
1673  gettimeofday( <unfinished ...>
1703  write(5, "\0", 1 <unfinished ...>
1673  <... gettimeofday resumed> {1382118569, 384699}, NULL) = 0
1703  <... write resumed> )             = 1
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  gettimeofday( <unfinished ...>
1673  <... select resumed> )            = 1 (in [4])
1703  <... gettimeofday resumed> {1382118569, 384768}, NULL) = 0
1673  read(4,  <unfinished ...>
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  <... read resumed> "\0", 16)      = 1
1703  <... clock_gettime resumed> {1382118569, 384820131}) = 0
1673  futex(0xb7751740, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
1703  futex(0xb7751740, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1703  <... futex resumed> )             = 0
1673  futex(0xb7751744, FUTEX_WAKE_OP_PRIVATE, 1, 1, 0xb7751740, {FUTEX_OP_SET, 0, FUTEX_OP_CMP_GT, 1} <unfinished ...>
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 107, {9, 615179869} <unfinished ...>
1673  <... futex resumed> )             = 0
1703  <... futex resumed> )             = -1 EAGAIN (Resource temporarily unavailable)
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  <... clock_gettime resumed> {1547, 285500143}) = 0
1703  <... futex resumed> )             = 0
1673  clock_gettime(CLOCK_MONOTONIC,  <unfinished ...>
1703  fdatasync(3 <unfinished ...>
1673  <... clock_gettime resumed> {1547, 285546583}) = 0
1673  gettimeofday({1382118569, 385046}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... fdatasync resumed> )         = 0
1703  write(5, "\0", 1)                 = 1
1673  <... select resumed> )            = 1 (in [4])
1703  gettimeofday( <unfinished ...>
1673  read(4,  <unfinished ...>
1703  <... gettimeofday resumed> {1382118569, 385173}, NULL) = 0
1673  <... read resumed> "\0", 16)      = 1
1703  clock_gettime(CLOCK_REALTIME,  <unfinished ...>
1673  write(9, "\1\0\0\0\0\0\0\0", 8 <unfinished ...>
1703  <... clock_gettime resumed> {1382118569, 385224827}) = 0
1673  <... write resumed> )             = 8
1703  futex(0xb7751744, FUTEX_WAIT_PRIVATE, 109, {9, 614775173} <unfinished ...>
1673  sendmsg(10, {msg_name(0)=NULL, msg_iov(1)=[{"gDf\230\0\0\0\0\310\260t\366\370J\2\301", 16}], msg_controllen=0, msg_flags=0}, 0) = 16
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1547, 285949140}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1547, 285981055}) = 0
1673  gettimeofday({1382118569, 385470}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 1 (in [8])
1673  read(8, "\2\0\0\0\0\0\0\0", 512)  = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1547, 286123551}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1547, 286154627}) = 0
1673  gettimeofday({1382118569, 385644}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... futex resumed> )             = ? ERESTART_RESTARTBLOCK (To be restarted)
1673  <... select resumed> )            = ? ERESTARTNOHAND (To be restarted)
1703  restart_syscall(<... resuming interrupted call ...> <unfinished ...>
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>
1703  <... restart_syscall resumed> )   = -1 ETIMEDOUT (Connection timed out)
1703  futex(0xb7751700, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
1673  <... select resumed> )            = 1 (in [10])
1703  <... futex resumed> )             = 0
1673  recvmsg(10,  <unfinished ...>
1703  madvise(0xb6748000, 8368128, MADV_DONTNEED <unfinished ...>
1673  <... recvmsg resumed> {msg_name(0)=NULL, msg_iov(1)=[{"\260\225x\21\2\0\0\0\310\260t\366\370J\2\301\0\0\0\0\0\0100\0\2\0\0\0", 28}], msg_controllen=0, msg_flags=0}, 0) = 0
1703  <... madvise resumed> )           = 0
1673  write(2, "nbd.c:nbd_receive_request():L517"..., 46 <unfinished ...>
1703  _exit(0)                          = ?
1673  <... write resumed> )             = 46
1673  close(10)                         = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1557, 74014817}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1557, 74061538}) = 0
1673  gettimeofday({1382118599, 786373}, NULL) = 0
1673  select(9, [4 6 7 8], [], [], NULL) = 1 (in [8])
1673  read(8, "\1\0\0\0\0\0\0\0", 512)  = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1557, 74331119}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1557, 74384672}) = 0
1673  gettimeofday({1382118599, 786705}, NULL) = 0
1673  select(9, [4 6 7 8], [], [], NULL) = 1 (in [6])
1673  accept(6, {sa_family=AF_INET, sin_port=htons(38937), sin_addr=inet_addr("127.0.0.1")}, [16]) = 10
1673  fcntl64(10, F_GETFL)              = 0x2 (flags O_RDWR)
1673  fcntl64(10, F_SETFL, O_RDWR)      = 0
1673  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
1673  fcntl64(10, F_GETFL)              = 0x2 (flags O_RDWR)
1673  fcntl64(10, F_SETFL, O_RDWR|O_NONBLOCK) = 0
1673  write(9, "\1\0\0\0\0\0\0\0", 8)   = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1557, 75703933}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1557, 75736422}) = 0
1673  gettimeofday({1382118599, 788039}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL) = 1 (in [8])
1673  read(8, "\1\0\0\0\0\0\0\0", 512)  = 8
1673  clock_gettime(CLOCK_MONOTONIC, {1557, 75904339}) = 0
1673  clock_gettime(CLOCK_MONOTONIC, {1557, 75939190}) = 0
1673  gettimeofday({1382118599, 788253}, NULL) = 0
1673  select(11, [4 7 8 10], [], [], NULL <unfinished ...>


4)----------

Unmounting temporary filesystems...done.a command-line.
Deactivating swap...done.
Unmounting local filesystems...umount2: Device or resource busy
[ 1665.357851] ------------[ cut here ]------------lly in 1 seconds.
[ 1665.362454] kernel BUG at /build/buildd-linux-2.6_2.6.32-45-i386-yQfQSv/linux-2.6-2.6.32/debian/build/source!
[ 1665.374668] invalid opcode: 0000 [#1] SMP
[ 1665.378781] last sysfs file: /sys/devices/virtual/block/nbd0/pid
[ 1665.384765] Modules linked in: ext3 jbd loop snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_hwdep snd]
[ 1665.419821]
[ 1665.421310] Pid: 1956, comm: umount Not tainted (2.6.32-5-686 #1) CBxx55/56
[ 1665.428246] EIP: 0060:[<c10cdac4>] EFLAGS: 00010246 CPU: 4
[ 1665.433714] EIP is at submit_bh+0x17/0x106
[ 1665.437795] EAX: 000004c1 EBX: f6bd80c0 ECX: 00000004 EDX: 00000005
[ 1665.444041] ESI: f6597c00 EDI: 000004c1 EBP: 00000001 ESP: f6cdde90
[ 1665.450284]  DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 1665.455663] Process umount (pid: 1956, ti=f6cdc000 task=f6cff700 task.ti=f6cdc000)
[ 1665.463203] Stack:
[ 1665.465207]  f6bd80c0 f6597c00 c31fa000 c10cefe6 f6597c14 f6597c00 f8ae039c f6bd80c0
[ 1665.472850] <0> f6597c00 00000007 f6597cc0 f6597c84 f8adf173 00000000 f6597c00 f8ae1161
[ 1665.480960] <0> f6597c14 f6596200 f6597c00 c31f7400 ffffffe2 f8b1c0d1 c31f7400 f6597000
[ 1665.489252] Call Trace:
[ 1665.491693]  [<c10cefe6>] ? sync_dirty_buffer+0x46/0x83
[ 1665.496902]  [<f8ae039c>] ? journal_update_superblock+0x67/0x99 [jbd]
[ 1665.503322]  [<f8adf173>] ? cleanup_journal_tail+0xb7/0xbc [jbd]
[ 1665.509308]  [<f8ae1161>] ? journal_flush+0x99/0x123 [jbd]
[ 1665.514776]  [<f8b1c0d1>] ? ext3_mark_recovery_complete+0x21/0x67 [ext3]
[ 1665.521456]  [<f8b1d1d8>] ? ext3_remount+0x133/0x28d [ext3]
[ 1665.527011]  [<f8b1d0a5>] ? ext3_remount+0x0/0x28d [ext3]
[ 1665.532394]  [<c10b4e19>] ? do_remount_sb+0xc2/0xfc
[ 1665.537254]  [<c10c6713>] ? do_mount+0x221/0x69e
[ 1665.541858]  [<c113c4f3>] ? copy_from_user+0x27/0x10e
[ 1665.546894]  [<c10c6bf6>] ? sys_mount+0x66/0x98
[ 1665.551412]  [<c10030fb>] ? sysenter_do_call+0x12/0x28
[ 1665.551414] 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
[ 1665.551436] EIP: [<c10cdac4>] submit_bh+0x17/0x106 SS:ESP 0068:f6cdde90
[ 1665.551447] ---[ end trace a739b219971062e9 ]---
/etc/rc0.d/K17umountfs: line 19:  1956 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.

^ permalink raw reply	[flat|nested] 9+ messages in thread

end of thread, other threads:[~2013-10-18 18:24 UTC | newest]

Thread overview: 9+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2013-09-26 20:48 [Qemu-devel] [Nbd] Hibernate and qemu-nbd Mark Trumpold
2013-09-27  5:18 ` Stefan Hajnoczi
2013-10-04 14:30   ` Mark Trumpold
2013-10-10  9:15     ` Stefan Hajnoczi
2013-10-15 15:17       ` Stefan Hajnoczi
  -- strict thread matches above, loose matches on Subject: below --
2013-10-18 18:23 Mark Trumpold
2013-10-17 17:07 Mark Trumpold
2013-10-17 19:53 ` Paul Clements
2013-09-25 14:42 [Qemu-devel] " Mark Trumpold
2013-09-26 19:46 ` [Qemu-devel] [Nbd] " Wouter Verhelst

This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).