[Ocfs2-users] Too much journaling or not ?

Tao Ma tao.ma at oracle.com
Fri Jul 30 07:33:27 PDT 2010


Hi Somsak,

On 07/30/2010 12:54 AM, Somsak Sriprayoonsakul wrote:
> Hi,
>
> (I am in the same team with Mr. Wanchat)
>
> Just want to note that we already format OCFS2 with -T mail option. As
> note below, data=writeback,noatime, and commit interval has been
> increase already.
>
> The weird thing about this problem is that, OCFS2 will work for like
> about 30 days, after that the I/O delay time will increase greatly, to
> the point that the system is unusable at all.
>

> This problem is quite serious for us. It disrupt the services every
> month. Right now the only cure we found is by formating another SAN and
> copy everything there (we did it with rsync).
>
> Right now the old SAN which contains the file system with trouble is
> still left intact. We can play around with it since it is not in
> production anymore. We can do some debugging on this. Just let us know
> what we should do.
I would guess that is because of the file system fragmentation.
So do you have stat_sysdir output?

And also if you don't mind, can you give us the o2image of the disk? 
with it we can try to reproduce it locally. For more information about 
o2image, see man page.
Also please tell us how to reproduce the case in your env.

Regards,
Tao

>
>
> Somsak
>
> somsaks at gmail.com <mailto:somsaks at gmail.com>
>
>
>
> On Wed, Jul 28, 2010 at 12:33 PM, wanchat padungrat
> <wanchat.p at pantip.com <mailto:wanchat.p at pantip.com>> wrote:
>
>     Dear Sunil,
>     Thank you for your promptly reply,
>     Yes, we do mount as data=writeback .
>     following is our current mount option : type ocfs2
>     (rw,_netdev,noatime,commit=15,data=writeback,heartbeat=local)
>
>     Wanchat P.
>     2010/7/28 Sunil Mushran <sunil.mushran at oracle.com
>     <mailto:sunil.mushran at oracle.com>>
>
>         Have you tried mounting with data=writeback ?
>
>
>         On Jul 27, 2010, at 9:31 PM, wanchat padungrat
>         <wanchat.p at pantip.com <mailto:wanchat.p at pantip.com>> wrote:
>
>>         Dear all,
>>
>>         Not realy sure whether this is bug or not, but we found that
>>         sometimes OCFS2 on our system do journaling a lot.
>>
>>         (Please see screen shot below)
>>
>>         As you can see, the IO was jumped from 111 w/s to 11,960 w/s ,
>>         IO utilize jumped from 1.5% to 97% , %iowait jumped from 0.25%
>>         to 10.94%.
>>
>>         It will not come into question, if this happen in short time
>>         period (eg. 1-2 sec.) , but sometimes we found this persist
>>         for half an hour or even more.
>>
>>         Is this normal for OCFS2 or not ? How could I tune OCFS2 to
>>         avoid the above situation.
>>
>>         We also suspect the relation of this symptom with another
>>         problem similar to
>>         <http://oss.oracle.com/pipermail/ocfs2-users/2009-January/003250.html>http://oss.oracle.com/pipermail/ocfs2-users/2009-January/003250.html
>>         , because we found OCFS2 file system pause for a long period
>>         of time too ( 5-20 Sec. on open for write). Those scattered
>>         happen all day with more frequence during highload time.
>>         (Screen shot below)
>>
>>         Our configuration is 3 web servers connect to HP SAN Storage
>>         using OCFS2 1.4.7. Amongst those 3 servers , there are 2 for
>>         reading data and 1 for writing data (traffic seperate at proxy
>>         layer) . The symptom above happen on data writing server.
>>
>>         Thank you.
>>
>>         Wanchat Padungrat
>>
>>         PS. We keep our service by reinstall the whole data every
>>         month, without doing whole data copy (consumed 12 hours), the
>>         symptom getting worse an worse eg. journaling persist longer ,
>>         file system pause longer (sometimes more than a minute !!) ...
>>         which affect the whole system , such as, too many waiting
>>         apache process, lavg going skyrocket(sometimes 400+) and
>>         cannot recover itself etc. .
>>
>>          
>>
>>         Screen shot
>>
>>         -----------------
>>
>>         -----------------------------------------------------------------------------
>>
>>         Here is iostat+top during journaling process running.
>>
>>         -----------------------------------------------------------------------------
>>
>>         avg-cpu: %user %nice %system %iowait %steal %idle
>>
>>         1.88 0.00 5.38 10.94 0.00 81.81
>>
>>         Device: rrqm/s wrqm/s r/s w/s rkB/s wkB/s avgrq-sz avgqu-sz
>>         await svctm %util
>>
>>         sda 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sda1 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sda2 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sdb 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sdb1 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sdc 0.00 5156.00 5.00 6804.50 19.00 47892.25 14.07 9.76 1.43
>>         0.14 97.55
>>
>>         sdc1 0.00 5156.00 5.00 6804.50 19.00 47892.25 14.07 9.76 1.43
>>         0.14 97.60
>>
>>         sdd 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sdd1 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sde 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sde1 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         dm-0 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         dm-1 0.00 0.00 5.00 11960.00 19.00 47838.25 8.00 13.65 1.14
>>         0.08 97.25
>>
>>         dm-2 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         dm-3 0.00 0.00 5.00 11960.00 19.00 47838.25 8.00 13.66 1.14
>>         0.08 97.30
>>
>>         -------------------------------------------------------------------------------------------
>>
>>         Tasks: 215 total, 2 running, 213 sleeping, 0 stopped, 0 zombie
>>
>>         Cpu(s): 2.5%us, 3.6%sy, 0.0%ni, 81.9%id, 10.9%wa, 0.0%hi,
>>         1.1%si, 0.0%st
>>
>>         Mem: 12298636k total, 11783892k used, 514744k free, 1679156k
>>         buffers
>>
>>         Swap: 2048276k total, 396k used, 2047880k free, 6149700k cached
>>
>>         PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND
>>
>>         3416 root 10 -5 0 0 0 S 5.7 0.0 473:10.53 o2net
>>
>>         10034 httpd 16 0 192m 18m 2476 D 3.7 0.2 0:43.44 httpd
>>
>>         16119 httpd 16 0 190m 16m 2200 S 3.7 0.1 0:25.65 httpd
>>
>>         6660 root 10 -5 0 0 0 D 3.3 0.0 39:15.14 ocfs2cmt <--- Journaling
>>
>>         20840 httpd 16 0 191m 16m 2168 D 3.3 0.1 0:14.99 httpd
>>
>>         6659 root 10 -5 0 0 0 S 3.0 0.0 34:32.57 kjournald <---
>>         Journaling
>>
>>         14282 httpd 16 0 190m 16m 2240 D 2.7 0.1 0:29.31 httpd
>>
>>         6656 root 11 -5 0 0 0 S 1.7 0.0 79:21.05 dlm_thread
>>
>>         17159 httpd 16 0 190m 16m 2240 D 1.7 0.1 0:24.06 httpd
>>
>>         14718 httpd 16 0 192m 18m 2408 D 1.3 0.2 0:28.30 httpd
>>
>>         6655 root 10 -5 0 0 0 S 1.0 0.0 12:02.41 ocfs2dc
>>
>>         10041 httpd 16 0 192m 18m 2252 R 1.0 0.2 0:41.68 httpd
>>
>>         14227 httpd 16 0 191m 17m 2248 D 1.0 0.1 0:29.96 httpd
>>
>>         14246 httpd 16 0 194m 20m 2236 D 1.0 0.2 0:30.14 httpd
>>
>>         19852 httpd 16 0 191m 16m 2160 D 1.0 0.1 0:16.72 httpd
>>
>>         25976 httpd 16 0 191m 16m 2148 D 1.0 0.1 0:05.45 httpd
>>
>>         6658 root 11 -5 0 0 0 S 0.7 0.0 86:50.46 dlm_wq
>>
>>         7387 httpd 16 0 201m 27m 2284 D 0.7 0.2 0:49.53 httpd
>>
>>         9843 httpd 16 0 191m 17m 2288 D 0.7 0.1 0:40.68 httpd
>>
>>         -------------------------------------------------------------------------------------------
>>
>>         Here is iostat+top during journaling process sleep (normal run).
>>
>>         -------------------------------------------------------------------------------------------
>>
>>         avg-cpu: %user %nice %system %iowait %steal %idle
>>
>>         3.00 0.00 2.31 0.25 0.00 94.44
>>
>>         Device: rrqm/s wrqm/s r/s w/s rkB/s wkB/s avgrq-sz avgqu-sz
>>         await svctm %util
>>
>>         sda 0.00 26.00 0.00 10.50 0.00 146.00 27.81 0.13 12.05 1.38 1.45
>>
>>         sda1 0.00 26.00 0.00 10.50 0.00 146.00 27.81 0.13 12.05 1.38 1.45
>>
>>         sda2 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sdb 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sdb1 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sdc 0.00 80.50 3.00 31.00 11.00 444.25 26.78 0.05 1.41 0.46 1.55
>>
>>         sdc1 0.00 80.50 3.00 31.00 11.00 444.25 26.78 0.05 1.41 0.46 1.55
>>
>>         sdd 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sdd1 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sde 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         sde1 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         dm-0 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         dm-1 0.00 0.00 3.00 111.50 11.00 444.25 7.95 0.13 1.10 0.14 1.55
>>
>>         dm-2 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00 0.00
>>
>>         dm-3 0.00 0.00 3.00 111.50 11.00 444.25 7.95 0.13 1.11 0.14 1.55
>>
>>         -------------------------------------------------------------------------------------------
>>
>>         top - 15:44:49 up 12 days, 2:21, 1 user, load average: 0.72,
>>         9.27, 15.66
>>
>>         Tasks: 215 total, 1 running, 214 sleeping, 0 stopped, 0 zombie
>>
>>         Cpu(s): 2.2%us, 1.0%sy, 0.0%ni, 96.0%id, 0.2%wa, 0.0%hi,
>>         0.5%si, 0.0%st
>>
>>         Mem: 12298636k total, 11832348k used, 466288k free, 1688052k
>>         buffers
>>
>>         Swap: 2048276k total, 396k used, 2047880k free, 6215116k cached
>>
>>         PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND
>>
>>         26088 httpd 16 0 189m 15m 2152 S 4.0 0.1 0:11.31 httpd
>>
>>         3416 root 11 -5 0 0 0 S 3.3 0.0 474:07.19 o2net
>>
>>         29193 httpd 15 0 191m 17m 2152 S 3.0 0.1 0:05.16 httpd
>>
>>         9842 httpd 15 0 191m 17m 2252 S 2.7 0.1 0:47.80 httpd
>>
>>         14329 httpd 15 0 191m 16m 2240 S 2.7 0.1 0:35.21 httpd
>>
>>         13245 httpd 15 0 190m 16m 2272 S 1.7 0.1 0:37.53 httpd
>>
>>         14719 httpd 16 0 190m 16m 2240 S 1.3 0.1 0:31.97 httpd
>>
>>         6658 root 11 -5 0 0 0 D 1.0 0.0 86:59.26 dlm_wq
>>
>>         10039 httpd 16 0 190m 16m 2328 S 0.7 0.1 0:44.13 httpd
>>
>>         10041 httpd 16 0 191m 17m 2252 S 0.7 0.1 0:46.10 httpd
>>
>>         16120 httpd 15 0 190m 16m 2240 S 0.7 0.1 0:36.17 httpd
>>
>>         6656 root 10 -5 0 0 0 D 0.3 0.0 79:35.89 dlm_thread
>>
>>         9844 httpd 15 0 188m 14m 2260 S 0.3 0.1 0:47.96 httpd
>>
>>         9845 httpd 15 0 191m 17m 2292 S 0.3 0.1 0:46.30 httpd
>>
>>         14227 httpd 15 0 192m 18m 2248 S 0.3 0.2 0:35.18 httpd
>>
>>         14232 httpd 15 0 190m 16m 2244 S 0.3 0.1 0:33.24 httpd
>>
>>         14247 httpd 15 0 190m 16m 2164 S 0.3 0.1 0:35.52 httpd
>>
>>         14281 httpd 15 0 189m 15m 2272 S 0.3 0.1 0:36.51 httpd
>>
>>         14327 httpd 15 0 192m 18m 2196 S 0.3 0.2 0:35.16 httpd
>>
>>         14331 httpd 15 0 190m 16m 2240 S 0.3 0.1 0:33.99 httpd
>>
>>          
>>
>>         -------------------------------------------------------------------------------------------
>>
>>         Lag on open file for write shown by strace simple cp command,
>>
>>         the symptom appear at bottom of the list
>>
>>         ------------------------------------------------------------------------------------------
>>
>>         [root at cafe4 wanchat-san1]# strace -T cp source_file
>>         destiantion_file
>>
>>         execve("/bin/cp", ["cp", "source_file", "destiantion_file"],
>>         [/* 22 vars */]) = 0 <0.000210>
>>
>>         brk(0) = 0x2347000 <0.000006>
>>
>>         mmap(NULL, 4096, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b6d685af000 <0.000006>
>>
>>         uname({sys="Linux", node="
>>         <http://cafe4.pantip.com/>cafe4.pantip.com
>>         <http://cafe4.pantip.com/>", ...}) = 0 <0.000006>
>>
>>         access("/etc/ld.so.preload", R_OK) = -1 ENOENT (No such file
>>         or directory) <0.000008>
>>
>>         open("/etc/ld.so.cache", O_RDONLY) = 3 <0.000009>
>>
>>         fstat(3, {st_mode=S_IFREG|0644, st_size=63180, ...}) = 0
>>         <0.000006>
>>
>>         mmap(NULL, 63180, PROT_READ, MAP_PRIVATE, 3, 0) =
>>         0x2b6d685b0000 <0.000010>
>>
>>         close(3) = 0 <0.000007>
>>
>>         open("/lib64/libacl.so.1", O_RDONLY) = 3 <0.000013>
>>
>>         read(3,
>>         "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0\31`\0379\0\0\0"...,
>>         832) = 832 <0.000008>
>>
>>         fstat(3, {st_mode=S_IFREG|0755, st_size=28008, ...}) = 0
>>         <0.000020>
>>
>>         mmap(NULL, 4096, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b6d685c0000 <0.000008>
>>
>>         mmap(0x391f600000, 2120992, PROT_READ|PROT_EXEC,
>>         MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x391f600000 <0.000010>
>>
>>         mprotect(0x391f606000, 2093056, PROT_NONE) = 0 <0.000012>
>>
>>         mmap(0x391f805000, 4096, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x5000) = 0x391f805000
>>         <0.000007>
>>
>>         close(3) = 0 <0.000005>
>>
>>         open("/lib64/libselinux.so.1", O_RDONLY) = 3 <0.000007>
>>
>>         read(3,
>>         "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0`E\240\0369\0\0\0"...,
>>         832) = 832 <0.000006>
>>
>>         fstat(3, {st_mode=S_IFREG|0755, st_size=95464, ...}) = 0
>>         <0.000005>
>>
>>         mmap(0x391ea00000, 2192784, PROT_READ|PROT_EXEC,
>>         MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x391ea00000 <0.000007>
>>
>>         mprotect(0x391ea15000, 2097152, PROT_NONE) = 0 <0.000007>
>>
>>         mmap(0x391ec15000, 8192, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x15000) =
>>         0x391ec15000 <0.000011>
>>
>>         mmap(0x391ec17000, 1424, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x391ec17000
>>         <0.000010>
>>
>>         close(3) = 0 <0.000007>
>>
>>         open("/lib64/libattr.so.1", O_RDONLY) = 3 <0.000012>
>>
>>         read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\320\17
>>         \0369\0\0\0"..., 832) = 832 <0.000007>
>>
>>         fstat(3, {st_mode=S_IFREG|0755, st_size=17888, ...}) = 0
>>         <0.000005>
>>
>>         mmap(0x391e200000, 2110728, PROT_READ|PROT_EXEC,
>>         MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x391e200000 <0.000007>
>>
>>         mprotect(0x391e204000, 2093056, PROT_NONE) = 0 <0.000011>
>>
>>         mmap(0x391e403000, 4096, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3000) = 0x391e403000
>>         <0.000012>
>>
>>         close(3) = 0 <0.000007>
>>
>>         open("/lib64/libc.so.6", O_RDONLY) = 3 <0.000012>
>>
>>         read(3,
>>         "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\332!\0359\0\0\0"...,
>>         832) = 832 <0.000009>
>>
>>         fstat(3, {st_mode=S_IFREG|0755, st_size=1717800, ...}) = 0
>>         <0.000005>
>>
>>         mmap(NULL, 4096, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b6d685c1000 <0.000009>
>>
>>         mmap(0x391d200000, 3498328, PROT_READ|PROT_EXEC,
>>         MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x391d200000 <0.000009>
>>
>>         mprotect(0x391d34d000, 2097152, PROT_NONE) = 0 <0.000009>
>>
>>         mmap(0x391d54d000, 20480, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x14d000) =
>>         0x391d54d000 <0.000011>
>>
>>         mmap(0x391d552000, 16728, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x391d552000
>>         <0.000014>
>>
>>         close(3) = 0 <0.000005>
>>
>>         open("/lib64/libdl.so.2", O_RDONLY) = 3 <0.000012>
>>
>>         read(3,
>>         "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20\16`\0359\0\0\0"...,
>>         832) = 832 <0.000008>
>>
>>         fstat(3, {st_mode=S_IFREG|0755, st_size=23360, ...}) = 0
>>         <0.000007>
>>
>>         mmap(0x391d600000, 2109696, PROT_READ|PROT_EXEC,
>>         MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x391d600000 <0.000009>
>>
>>         mprotect(0x391d602000, 2097152, PROT_NONE) = 0 <0.000007>
>>
>>         mmap(0x391d802000, 8192, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2000) = 0x391d802000
>>         <0.000007>
>>
>>         close(3) = 0 <0.000005>
>>
>>         open("/lib64/libsepol.so.1", O_RDONLY) = 3 <0.000009>
>>
>>         read(3,
>>         "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0=`\0369\0\0\0"...,
>>         832) = 832 <0.000006>
>>
>>         fstat(3, {st_mode=S_IFREG|0755, st_size=247496, ...}) = 0
>>         <0.000005>
>>
>>         mmap(0x391e600000, 2383136, PROT_READ|PROT_EXEC,
>>         MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x391e600000 <0.000006>
>>
>>         mprotect(0x391e63b000, 2097152, PROT_NONE) = 0 <0.000007>
>>
>>         mmap(0x391e83b000, 4096, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3b000) =
>>         0x391e83b000 <0.000008>
>>
>>         mmap(0x391e83c000, 40224, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x391e83c000
>>         <0.000007>
>>
>>         close(3) = 0 <0.000005>
>>
>>         mmap(NULL, 4096, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b6d685c2000 <0.000005>
>>
>>         mmap(NULL, 4096, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b6d685c3000 <0.000005>
>>
>>         arch_prctl(ARCH_SET_FS, 0x2b6d685c2f90) = 0 <0.000005>
>>
>>         mprotect(0x391d54d000, 16384, PROT_READ) = 0 <0.000007>
>>
>>         mprotect(0x391d802000, 4096, PROT_READ) = 0 <0.000006>
>>
>>         mprotect(0x391d01b000, 4096, PROT_READ) = 0 <0.000005>
>>
>>         munmap(0x2b6d685b0000, 63180) = 0 <0.000010>
>>
>>         access("/etc/selinux/", F_OK) = 0 <0.000007>
>>
>>         brk(0) = 0x2347000 <0.000005>
>>
>>         brk(0x2368000) = 0x2368000 <0.000005>
>>
>>         open("/etc/selinux/config", O_RDONLY) = 3 <0.000013>
>>
>>         fstat(3, {st_mode=S_IFREG|0644, st_size=511, ...}) = 0 <0.000005>
>>
>>         mmap(NULL, 4096, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b6d685b0000 <0.000005>
>>
>>         read(3, "# This file controls the state o"..., 4096) = 511
>>         <0.000009>
>>
>>         read(3, "", 4096) = 0 <0.000006>
>>
>>         close(3) = 0 <0.000006>
>>
>>         munmap(0x2b6d685b0000, 4096) = 0 <0.000008>
>>
>>         open("/proc/mounts", O_RDONLY) = 3 <0.000033>
>>
>>         fstat(3, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0 <0.000005>
>>
>>         mmap(NULL, 4096, PROT_READ|PROT_WRITE,
>>         MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x2b6d685b0000 <0.000005>
>>
>>         read(3, "rootfs / rootfs rw 0 0\n/dev/root"..., 4096) = 667
>>         <0.000041>
>>
>>         read(3, "", 4096) = 0 <0.000005>
>>
>>         close(3) = 0 <0.000006>
>>
>>         munmap(0x2b6d685b0000, 4096) = 0 <0.000007>
>>
>>         open("/proc/filesystems", O_RDONLY) = 3 <0.000011>
>>
>>         read(3, "nodev\tsysfs\nnodev\trootfs\nnodev\tb"..., 4095) =
>>         354 <0.000014>
>>
>>         close(3) = 0 <0.000006>
>>
>>         open("/usr/lib/locale/locale-archive", O_RDONLY) = 3 <0.000010>
>>
>>         fstat(3, {st_mode=S_IFREG|0644, st_size=56471264, ...}) = 0
>>         <0.000005>
>>
>>         mmap(NULL, 56471264, PROT_READ, MAP_PRIVATE, 3, 0) =
>>         0x2b6d685c4000 <0.000006>
>>
>>         close(3) = 0 <0.000004>
>>
>>         geteuid() = 0 <0.000006>
>>
>>         stat("destiantion_file", {st_mode=S_IFREG|0644, st_size=1307,
>>         ...}) = 0 <0.000013>
>>
>>         stat("source_file", {st_mode=S_IFREG|0644, st_size=1307, ...})
>>         = 0 <0.000009>
>>
>>         stat("destiantion_file", {st_mode=S_IFREG|0644, st_size=1307,
>>         ...}) = 0 <0.000008>
>>
>>         open("source_file", O_RDONLY) = 3 <0.000022>
>>
>>         fstat(3, {st_mode=S_IFREG|0644, st_size=1307, ...}) = 0 <0.000005>
>>
>>         open("destiantion_file", O_WRONLY|O_TRUNC) = 4 <8.159196>
>>         <------ 8 Sec ! During normal condition 0.000034
>>
>>         fstat(4, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0 <0.000008>
>>
>>         fstat(3, {st_mode=S_IFREG|0644, st_size=1307, ...}) = 0 <0.000007>
>>
>>         read(3, "Linux 2.6.18-194.3.1.el5 (cafe4."..., 4096) = 1307
>>         <0.000012>
>>
>>         write(4, "Linux 2.6.18-194.3.1.el5 (cafe4."..., 1307) = 1307
>>         <0.003315>
>>
>>         read(3, "", 4096) = 0 <0.000010>
>>
>>         close(4) = 0 <0.000006>
>>
>>         close(3) = 0 <0.000007>
>>
>>         close(1) = 0 <0.000005>
>>
>>         exit_group(0) = ?
>>
>>         _______________________________________________
>>         Ocfs2-users mailing list
>>         Ocfs2-users at oss.oracle.com <mailto:Ocfs2-users at oss.oracle.com>
>>         http://oss.oracle.com/mailman/listinfo/ocfs2-users
>
>         _______________________________________________
>         Ocfs2-users mailing list
>         Ocfs2-users at oss.oracle.com <mailto:Ocfs2-users at oss.oracle.com>
>         http://oss.oracle.com/mailman/listinfo/ocfs2-users
>
>
>
>     _______________________________________________
>     Ocfs2-users mailing list
>     Ocfs2-users at oss.oracle.com <mailto:Ocfs2-users at oss.oracle.com>
>     http://oss.oracle.com/mailman/listinfo/ocfs2-users
>
>
>
>
> _______________________________________________
> Ocfs2-users mailing list
> Ocfs2-users at oss.oracle.com
> http://oss.oracle.com/mailman/listinfo/ocfs2-users



More information about the Ocfs2-users mailing list