RE: [Fwd: Re: Caching of reads]

Fwd: Re: Caching of reads Alex J Lennon 2 participants 3 messages Nov 16, 2001 1 message not in the archive Memory technology devices (MTD)

lore

Share & tools

lore

A message that is not in the archive (sent off-list or not yet received): 1005926529.15603.29.camel@LinuxDev

Alex J Lennon

author

2001-11-16 17:54 UTC #1 lore raw

Quoted 4 lines

Strange. JFFS2 doesn't do caching - that's supposed to be handle by the Linux VFS/VM. But set CONFIG_JFFS2_FS_DEBUG=1 and
echo 9 > /proc/sys/kernel/printk, then see what it's actually being asked to read each time.

An strace seems to show it's related to the fork(), shortly after the fork() ?

-Alex

--- SIGCHLD (Child exited) ---
wait4(-1, 0xbffff840, WNOHANG, NULL) = -1 ECHILD (No child processes)
sigreturn() = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x806c32c, [], 0x4000000}, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
stat("/bin/sleep", <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be1ea0
{st_mode=S_IFREG|0755, st_size=132432, ...}) = 0 rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
fork(<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsi
ze 7, csize 7, offset 0, buf c3be1ea0
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b,
csize b, offset 0, buf c3beec60
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d,
csize d, offset 0, buf c3be1ea0
) = 841
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigaction(SIGINT, {0x806c32c, [], 0x4000000}, {SIG_DFL}, 8) = 0 wait4(-1, [WIFEXITED(s) && WEXITSTATUS(s) == 0], 0, NULL) = 841 rt_sigprocmask(SIG_BLOCK, [CHLD TTOU], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) ---
wait4(-1, 0xbffff840, WNOHANG, NULL) = -1 ECHILD (No child processes)
sigreturn() = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x806c32c, [], 0x4000000}, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
stat("/bin/sleep", <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be1ea0
{st_mode=S_IFREG|0755, st_size=132432, ...}) = 0 rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
fork(<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsi
ze 7, csize 7, offset 0, buf c3be1ea0
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b,
csize b, offset 0, buf c3beec60
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d,
csize d, offset 0, buf c3be1ea0
) = 842
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigaction(SIGINT, {0x806c32c, [], 0x4000000}, {SIG_DFL}, 8) = 0 wait4(-1, [WIFEXITED(s) && WEXITSTATUS(s) == 0], 0, NULL) = 842 rt_sigprocmask(SIG_BLOCK, [CHLD TTOU], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0

_____________________________________________________________________
The message in this transmission is sent in confidence for the attention of the addressee only and should not be disclosed to any other party. Unauthorised recipients are requested to preserve this confidentiality. Please advise the sender if the addressee is not resident at the receiving end.

This message has been checked for all viruses by MessageLabs Virus Control Centre.

Company registered in England No. 1608562.
Registered Office: Unit 8, Clifton Road, Cambridge, CB1 7EA, United Kingdom, Tel: 01223 411200.

David Woodhouse

2001-11-16 21:56 UTC #2 lore raw

Quoted 2 lines

An strace seems to show it's related to the fork(), shortly after the fork()

There should be more debug info than that from JFFS2, shouldn't there?

Quoted 7 lines

<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsize 7, csize 7, offset 0, buf c3be1ea0 <7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b, csize b, offset 0, buf c3beec60 <7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d, csize d, offset 0, buf c3be1ea0 <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsize 7, csize 7, offset 0, buf c3be1ea0 <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsize 7, csize 7, offset 0, buf c3be1ea0 <7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b, csize b, offset 0, buf c3beec60 <7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d, csize d, offset 0, buf c3be1ea0

Are you sure that's right? Those sizes look suspicious. But it definitely looks like some of those nodes are being read repeatedly - I don't know why they're being dropped from the page cache. What kernel, precisely?

Quoted 5 lines

The message in this transmission is sent in confidence for the attention of the addressee only and should not be disclosed to any other party. Unauthorised recipients are requested to preserve this confidentiality. Please advise the sender if the addressee is not resident at the receiving end.

Please could you turn that off?

--
dwmw2

Alex J Lennon

author

2001-11-16 23:24 UTC #3 lore raw

Quoted 1 line

There should be more debug info than that from JFFS2, shouldn't there?

That's what I get with verbosity = 1
I've attached another partial log generated with verbosity = 3

Quoted 1 line

Are you sure that's right? Those sizes look suspicious. But it definitely

Absolutely not - but it is what the kernel is logging.

Quoted 3 lines

looks like some of those nodes are being read repeatedly - I don't know why
they're being dropped from the page cache. What kernel, precisely?

kernel.org 2.4.14, patched with the Linus VM fix
(http://www.uwsg.indiana.edu/hypermail/linux/kernel/0111.0/1084.html)

.config attached also

Quoted 1 line

Please could you turn that off?

Given the option it would be :(

Any thoughts on where we should be looking ?

Best,

-Alex

Quoted 50 lines

-----Original Message-----
From: [email protected] [mailto:[email protected]]On Behalf Of David Woodhouse
Sent: Friday, November 16, 2001 4:05 PM
To: Alex J Lennon
Cc: Ian Campbell; Linux MTD Mailing List
Subject: Re: [Fwd: Re: Caching of reads]
Quoted 1 line
An strace seems to show it's related to the fork(), shortly
after the fork()
There should be more debug info than that from JFFS2, shouldn't there?
Quoted 1 line
<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be1ea0
Quoted 1 line
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC
b16a4fa6. dsize b, csize b, offset 0, buf c3beec60
Quoted 1 line
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC
544bdb58. dsize d, csize d, offset 0, buf c3be1ea0
Quoted 1 line
<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be1ea0
Quoted 1 line
<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be1ea0
Quoted 1 line
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC
b16a4fa6. dsize b, csize b, offset 0, buf c3beec60
Quoted 1 line
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC
544bdb58. dsize d, csize d, offset 0, buf c3be1ea0
Are you sure that's right? Those sizes look suspicious. But it definitely looks like some of those nodes are being read repeatedly - I don't know why
they're being dropped from the page cache. What kernel, precisely?
Quoted 5 lines
The message in this transmission is sent in confidence for the attention of the addressee only and should not be disclosed to any other party. Unauthorised recipients are requested to preserve this confidentiality. Please advise the sender if the addressee is not resident at the receiving end.
Please could you turn that off?
--
dwmw2

Quoted 8 lines

______________________________________________________
Linux MTD discussion mailing list
http://lists.infradead.org/mailman/listinfo/linux-mtd/
_____________________________________________________________________
This message has been checked for all viruses by MessageLabs Virus Control Centre.

This message has been checked for all viruses by MessageLabs Virus Control Centre.

Company registered in England No. 1608562.
Registered Office: Unit 8, Clifton Road, Cambridge, CB1 7EA, United Kingdom, Tel: 01223 411200.

wait4(-1, [WIFEXITED(s) && WEXITSTATUS(s) == 0], 0, NULL) = 113 rt_sigprocmask(SIG_BLOCK, [CHLD TTOU], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) ---
wait4(-1, 0xbffff840, WNOHANG, NULL) = -1 ECHILD (No child processes)
sigreturn() = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x806c32c, [], 0x4000000}, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
stat("/bin/sleep", <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
{st_mode=S_IFREG|0755, st_size=132432, ...}) = 0 rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
fork(<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsi ze 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b,
csize b, offset 0, buf c3be31e0
<7>Read 11 bytes to c3be31e0
<7>Data CRC matches calculated CRC 1193fcf4
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d,
csize d, offset 0, buf c3be3220
<7>Read 13 bytes to c3be3220
<7>Data CRC matches calculated CRC 808bf9b7
) = 114
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGINT, {0x806c32c, [], 0x4000000}, {SIG_DFL}, 8) = 0 wait4(-1, [WIFEXITED(s) && WEXITSTATUS(s) == 0], 0, NULL) = 114 rt_sigprocmask(SIG_BLOCK, [CHLD TTOU], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) ---
wait4(-1, 0xbffff840, WNOHANG, NULL) = -1 ECHILD (No child processes)
sigreturn() = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x806c32c, [], 0x4000000}, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
stat("/bin/sleep", <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
{st_mode=S_IFREG|0755, st_size=132432, ...}) = 0 rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
fork(<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsi ze 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b,
csize b, offset 0, buf c3be31e0
<7>Read 11 bytes to c3be31e0
<7>Data CRC matches calculated CRC 1193fcf4
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d,
csize d, offset 0, buf c3be3220
<7>Read 13 bytes to c3be3220
<7>Data CRC matches calculated CRC 808bf9b7
) = 115
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGINT, {0x806c32c, [], 0x4000000}, {SIG_DFL}, 8) = 0 wait4(-1, [WIFEXITED(s) && WEXITSTATUS(s) == 0], 0, NULL) = 115 rt_sigprocmask(SIG_BLOCK, [CHLD TTOU], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) ---
wait4(-1, 0xbffff840, WNOHANG, NULL) = -1 ECHILD (No child processes)
sigreturn() = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x806c32c, [], 0x4000000}, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
stat("/bin/sleep", <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
{st_mode=S_IFREG|0755, st_size=132432, ...}) = 0 rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
fork(<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsi ze 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b,
csize b, offset 0, buf c3be31e0
<7>Read 11 bytes to c3be31e0
<7>Data CRC matches calculated CRC 1193fcf4
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d,
csize d, offset 0, buf c3be3220
<7>Read 13 bytes to c3be3220
<7>Data CRC matches calculated CRC 808bf9b7
) = 116
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGINT, {0x806c32c, [], 0x4000000}, {SIG_DFL}, 8) = 0 wait4(-1, [WIFEXITED(s) && WEXITSTATUS(s) == 0], 0, NULL) = 116 rt_sigprocmask(SIG_BLOCK, [CHLD TTOU], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) ---
wait4(-1, 0xbffff840, WNOHANG, NULL) = -1 ECHILD (No child processes)
sigreturn() = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x806c32c, [], 0x4000000}, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
stat("/bin/sleep", <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
{st_mode=S_IFREG|0755, st_size=132432, ...}) = 0 rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
fork() = 117
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGINT, {0x806c32c, [], 0x4000000}, {SIG_DFL}, 8) = 0 wait4(-1, <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771 . dsize 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b,
csize b, offset 0, buf c3be31e0
<7>Read 11 bytes to c3be31e0
<7>Data CRC matches calculated CRC 1193fcf4
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d,
csize d, offset 0, buf c3be3220
<7>Read 13 bytes to c3be3220
<7>Data CRC matches calculated CRC 808bf9b7
[WIFEXITED(s) && WEXITSTATUS(s) == 0], 0, NULL) = 117 rt_sigprocmask(SIG_BLOCK, [CHLD TTOU], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) ---
wait4(-1, 0xbffff840, WNOHANG, NULL) = -1 ECHILD (No child processes)
sigreturn() = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x806c32c, [], 0x4000000}, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
stat("/bin/sleep", <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
{st_mode=S_IFREG|0755, st_size=132432, ...}) = 0 rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
fork(<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsi ze 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b,
csize b, offset 0, buf c3be31e0
<7>Read 11 bytes to c3be31e0
<7>Data CRC matches calculated CRC 1193fcf4
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d,
csize d, offset 0, buf c3be3220
<7>Read 13 bytes to c3be3220
<7>Data CRC matches calculated CRC 808bf9b7
) = 118
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGINT, {0x806c32c, [], 0x4000000}, {SIG_DFL}, 8) = 0 wait4(-1, [WIFEXITED(s) && WEXITSTATUS(s) == 0], 0, NULL) = 118 rt_sigprocmask(SIG_BLOCK, [CHLD TTOU], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) ---
wait4(-1, 0xbffff840, WNOHANG, NULL) = -1 ECHILD (No child processes)
sigreturn() = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x806c32c, [], 0x4000000}, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
stat("/bin/sleep", <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
{st_mode=S_IFREG|0755, st_size=132432, ...}) = 0 rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
fork(<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsi ze 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b,
csize b, offset 0, buf c3be31e0
<7>Read 11 bytes to c3be31e0
<7>Data CRC matches calculated CRC 1193fcf4
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d,
csize d, offset 0, buf c3be3220
<7>Read 13 bytes to c3be3220
<7>Data CRC matches calculated CRC 808bf9b7
) = 119
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGINT, {0x806c32c, [], 0x4000000}, {SIG_DFL}, 8) = 0 wait4(-1, [WIFEXITED(s) && WEXITSTATUS(s) == 0], 0, NULL) = 119 rt_sigprocmask(SIG_BLOCK, [CHLD TTOU], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) ---
wait4(-1, 0xbffff840, WNOHANG, NULL) = -1 ECHILD (No child processes)
sigreturn() = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x806c32c, [], 0x4000000}, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
stat("/bin/sleep", <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
{st_mode=S_IFREG|0755, st_size=132432, ...}) = 0 rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
fork(<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsi ze 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b,
csize b, offset 0, buf c3be31e0
<7>Read 11 bytes to c3be31e0
<7>Data CRC matches calculated CRC 1193fcf4
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d,
csize d, offset 0, buf c3be3220
<7>Read 13 bytes to c3be3220
<7>Data CRC matches calculated CRC 808bf9b7
) = 120
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGINT, {0x806c32c, [], 0x4000000}, {SIG_DFL}, 8) = 0 wait4(-1, [WIFEXITED(s) && WEXITSTATUS(s) == 0], 0, NULL) = 120 rt_sigprocmask(SIG_BLOCK, [CHLD TTOU], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) ---
wait4(-1, 0xbffff840, WNOHANG, NULL) = -1 ECHILD (No child processes)
sigreturn() = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x806c32c, [], 0x4000000}, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
stat("/bin/sleep", <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
{st_mode=S_IFREG|0755, st_size=132432, ...}) = 0 rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
fork(<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsi ze 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b,
csize b, offset 0, buf c3be31e0
<7>Read 11 bytes to c3be31e0
<7>Data CRC matches calculated CRC 1193fcf4
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d,
csize d, offset 0, buf c3be3220
<7>Read 13 bytes to c3be3220
<7>Data CRC matches calculated CRC 808bf9b7
) = 121
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGINT, {0x806c32c, [], 0x4000000}, {SIG_DFL}, 8) = 0 wait4(-1, [WIFEXITED(s) && WEXITSTATUS(s) == 0], 0, NULL) = 121 rt_sigprocmask(SIG_BLOCK, [CHLD TTOU], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
--- SIGCHLD (Child exited) ---
wait4(-1, 0xbffff840, WNOHANG, NULL) = -1 ECHILD (No child processes)
sigreturn() = ? (mask now [])
rt_sigaction(SIGINT, {SIG_DFL}, {0x806c32c, [], 0x4000000}, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
stat("/bin/sleep", <7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC
f3b6e771. dsize 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
{st_mode=S_IFREG|0755, st_size=132432, ...}) = 0 rt_sigprocmask(SIG_BLOCK, [INT CHLD], [], 8) = 0
fork(<7>Node read from 00d9d8f4: node_crc f3b6e771, calculated CRC f3b6e771. dsi ze 7, csize 7, offset 0, buf c3be3220
<7>Read 7 bytes to c3be3220
<7>Data CRC matches calculated CRC 186b259f
<7>Node read from 00cec5c0: node_crc b16a4fa6, calculated CRC b16a4fa6. dsize b,
csize b, offset 0, buf c3be31e0
<7>Read 11 bytes to c3be31e0
<7>Data CRC matches calculated CRC 1193fcf4
<7>Node read from 00c55d1c: node_crc 544bdb58, calculated CRC 544bdb58. dsize d,
csize d, offset 0, buf c3be3220
<7>Read 13 bytes to c3be3220
<7>Data CRC matches calculated CRC 808bf9b7
) = 122
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [CHLD], 8) = 0 rt_sigprocmask(SIG_SETMASK, [CHLD], NULL, 8) = 0 rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0 rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGINT, {0x806c32c, [], 0x4000000}, {SIG_DFL}, 8) = 0