1752790 Members
6244 Online
108789 Solutions
New Discussion юеВ

collect error?

 
Nickolay
Occasional Advisor

collect error?

collect error?

I get statistics disks load by collect command:
collect -i 300 -etlnqmfy >/tmp/collect.txt

And I see high summary load "DISK Statistics" for dsk4 (clolumn %BSY) see .
But per process statistic shown that only one oracle process 40448 write to disk (OBk - 2).

I think, that summary load is incorrect because between 07AM and 08AM i have no transactions, jobs, no other activity in system.


#### RECORD 1403 (1114909562:137) (Sun May 1 07:06:02 2005) ####

# Process Statistics (RSS & VSZ in Decimal units, i.e 1K = 1000 bytes)
# PID User %CPU RSS VSZ UsrTim SysTim IBk OBk Maj Min Command
0 root 0.0 24M 2.4G 0.000 0.002 0 0 0 0 kernel idle
1 root 0.0 32K 622K 0.000 0.000 0 0 0 0 init
3 root 0.0 0K 1.7M 0.000 0.000 0 0 0 0 kloadsrv
5 root 0.0 73K 3.0M 0.000 0.000 0 0 0 0 hotswapd
51 root 0.0 0K 2.9M 0.000 0.000 0 0 0 0 esmd
62 root 0.0 49K 2.1M 0.000 0.001 0 0 0 0 update
178 root 0.0 638K 4.3M 0.000 0.000 0 0 0 0 evmd
212 root 0.0 229K 3.1M 0.000 0.000 0 0 0 0 evmlogger
213 root 0.0 196K 2.8M 0.000 0.000 0 0 0 0 evmchmgr
366 root 0.0 204K 2.9M 0.000 0.000 0 0 0 0 syslogd
369 root 0.0 65K 4.8M 0.000 0.000 0 0 0 0 sshd1
328052 ora817 0.0 278K 1.8G 0.000 0.000 0 0 0 0 oracle
373 root 0.0 180K 3.4M 0.000 0.000 0 0 0 0 binlogd
432 root 0.0 98K 2.5M 0.000 0.000 0 0 0 0 auditd
556 root 0.0 0K 3.4M 0.000 0.000 0 0 0 0 dnalimd
559 root 0.0 270K 4.2M 0.000 0.000 0 0 0 0 dnaevld
575 root 0.0 0K 3.2M 0.000 0.000 0 0 0 0 ctfd
612 root 0.0 0K 2.3M 0.000 0.000 0 0 0 0 x25applicationd
824 root 0.0 442K 8.6M 0.000 0.000 0 0 0 0 insightd
843 root 0.0 393K 5.9M 0.000 0.000 0 0 0 0 advfsd
846 root 0.0 417K 4.3M 0.000 0.000 0 0 0 0 config_hmmod
857 root 0.0 0K 2.3M 0.000 0.000 0 0 0 0 inetd
858 root 0.0 73K 2.3M 0.000 0.000 0 0 0 0 inetd
870 root 0.0 409K 4.3M 0.000 0.000 0 0 0 0 sysman_hmmod
944 root 0.0 1.8M 10M 0.000 0.000 0 0 0 0 java
974 root 0.0 532K 23M 0.000 0.000 0 0 0 0 smsd
328970 ora817 0.0 270K 1.8G 0.000 0.000 0 0 0 0 oracle
329540 ora817 0.0 1.1M 1.8G 0.000 0.000 0 0 0 0 oracle
329905 ora817 0.0 1.7M 1.8G 0.000 0.000 0 0 0 0 oracle
332650 acard 0.0 16K 3.2M 0.000 0.000 0 0 0 0 bash
332727 root 0.0 16K 2.4M 0.000 0.000 0 0 0 0 telnetd
400744 ora817 0.0 8.1M 1.8G 0.000 0.000 0 0 0 0 oracle
401498 ora817 0.0 7.4M 1.8G 0.000 0.000 0 0 0 0 oracle
402115 ora817 0.0 7.1M 1.8G 0.000 0.000 0 0 0 0 oracle
341175 ora817 0.0 540K 1.8G 0.000 0.000 0 0 0 0 oracle
212080 ora817 0.0 270K 1.8G 0.000 0.000 0 0 0 0 oracle
475286 root 0.0 0K 598K 0.000 0.000 0 0 0 0 getty
344990 acard 0.0 294K 3.2M 0.000 0.000 0 0 0 0 bash
411593 ora817 0.0 409K 1.8G 0.000 0.000 0 0 0 0 oracle
18895 root 0.0 221K 4.6M 0.000 0.000 0 0 0 0 cron
413014 ora817 0.0 9M 1.8G 0.000 0.000 0 0 0 0 oracle
414582 ora817 0.0 606K 1.8G 0.000 0.000 0 0 0 0 oracle
414839 ora817 0.0 581K 1.8G 0.000 0.000 0 0 0 0 oracle
283810 ora817 0.0 7.2M 1.8G 0.000 0.000 0 0 0 0 oracle
21735 ora817 0.0 647K 1.8G 0.000 0.000 0 0 0 0 oracle
415273 ora817 0.0 409K 1.8G 0.000 0.000 0 0 0 0 oracle
284543 ora817 0.0 253K 1.8G 0.000 0.000 0 0 0 0 oracle
287218 ora817 0.0 2.8M 1.8G 0.000 0.000 0 0 0 0 oracle
287839 ora817 0.0 155K 1.8G 0.000 0.000 0 0 0 0 oracle
354527 ora817 0.0 614K 1.8G 0.000 0.000 0 0 0 0 oracle
289004 acard 0.0 409K 12M 0.000 0.000 0 0 0 0 ppp2_1
420459 ora817 0.0 1.2M 1.8G 0.000 0.000 0 0 0 0 oracle
289702 ora817 0.0 155K 1.8G 0.000 0.000 0 0 0 0 oracle
289920 ora817 0.0 270K 1.8G 0.000 0.000 0 0 0 0 oracle
421082 ora817 0.0 163K 1.8G 0.000 0.000 0 0 0 0 oracle
290048 ora817 0.0 221K 1.8G 0.000 0.000 0 0 0 0 oracle
487840 ora817 0.0 221K 1.8G 0.000 0.000 0 0 0 0 oracle
357140 ora817 0.0 9M 1.8G 0.004 0.000 0 0 0 0 oracle
292591 acard 0.0 712K 13M 0.000 0.000 0 0 0 0 msglogger_pw
423691 root 0.0 139K 2.7M 0.000 0.000 0 0 0 0 vmstat.sh
292700 ora817 0.0 270K 1.8G 0.000 0.000 0 0 0 0 oracle
360762 ora817 0.0 647K 1.8G 0.000 0.000 0 0 0 0 oracle
295874 acard 0.0 229K 13M 0.000 0.000 0 0 0 0 tcpcomms
295976 acard 0.0 1.4M 14M 0.000 0.000 0 0 0 0 posint
361856 ora817 0.0 2.1M 1.8G 0.000 0.000 0 0 0 0 oracle
165347 ora817 0.0 860K 20M 0.000 0.000 0 0 0 0 dbsnmp
165349 ora817 0.0 581K 15M 0.000 0.000 0 0 0 0 dbsnmp
362533 root 0.0 6.0M 8.8M 0.000 0.000 0 0 0 0 collect
299105 ora817 0.0 671K 1.8G 0.000 0.000 0 0 0 0 oracle
37454 acard 0.0 139K 12M 0.000 0.000 0 0 0 0 atndnt_srv
37741 acard 0.0 434K 13M 0.000 0.000 0 0 0 0 atndnt_srv
37796 ora817 0.0 565K 1.8G 0.000 0.000 0 0 0 0 oracle
300391 acard 0.0 1.6M 14M 0.000 0.000 0 0 0 0 txrout
300427 acard 0.0 409K 12M 0.000 0.000 0 0 0 0 ppp2_3
300461 acard 0.0 229K 13M 0.000 0.000 0 0 0 0 x25comms_mcp
39607 ora817 0.0 802K 1.8G 0.000 0.000 0 0 0 0 oracle
301877 acard 0.0 376K 12M 0.000 0.000 0 0 0 0 ppp2_3
302300 acard 0.0 376K 12M 0.000 0.000 0 0 0 0 ppp2_1
302326 acard 0.0 1.1M 13M 0.000 0.000 0 0 0 0 voice_auth
367888 ora817 0.0 2.3M 1.8G 0.000 0.000 0 0 0 0 oracle
40448 ora817 0.0 475K 1.8G 0.000 0.000 0 2 0 0 oracle
302615 acard 0.0 376K 12M 0.000 0.000 0 0 0 0 ppp2_4
302670 acard 0.0 835K 13M 0.000 0.000 0 0 0 0 voice_auth
302710 ora817 0.0 1.1M 1.8G 0.000 0.000 0 0 0 0 oracle
302936 acard 0.0 393K 12M 0.000 0.000 0 0 0 0 msglogger_qw
302973 acard 0.0 409K 12M 0.000 0.000 0 0 0 0 ppp2_4
303015 acard 0.0 819K 13M 0.000 0.000 0 0 0 0 x25comms_int
303124 acard 0.0 409K 12M 0.000 0.000 0 0 0 0 hsmcomms_mcp
303173 acard 0.0 770K 13M 0.000 0.000 0 0 0 0 statrout
303240 acard 0.0 376K 12M 0.000 0.000 0 0 0 0 ppp2_3
303255 acard 0.0 385K 12M 0.000 0.000 0 0 0 0 ppp2_3
303292 acard 0.0 2.7M 16M 0.000 0.000 0 0 0 0 nwint00
303317 ora817 2.0 1.5M 1.8G 0.003 0.000 0 0 0 0 oracle
303323 acard 0.0 1.3M 13M 0.000 0.000 0 0 0 0 devmon00
303369 acard 0.0 1.3M 14M 0.000 0.000 0 0 0 0 hstint
303604 acard 0.0 4.6M 18M 0.000 0.000 0 0 0 0 atmi00
434729 ora817 0.0 647K 1.8G 0.000 0.000 0 0 0 0 oracle
303733 acard 0.0 1.9M 15M 0.000 0.000 0 0 0 0 stdauth
303770 ora817 0.1 1.9M 1.8G 0.000 0.000 0 0 0 0 oracle
303864 ora817 0.0 1.1M 1.8G 0.000 0.000 0 0 0 0 oracle
303886 ora817 0.0 1.1M 1.8G 0.000 0.000 0 0 0 0 oracle
303933 ora817 0.0 221K 1.8G 0.000 0.000 0 0 0 0 oracle
303963 ora817 0.0 1.5M 1.8G 0.000 0.000 0 0 0 0 oracle
304041 ora817 0.0 1.1M 1.8G 0.000 0.000 0 0 0 0 oracle
304061 ora817 0.1 1.4M 1.8G 0.000 0.000 0 0 0 0 oracle
304108 acard 0.0 745K 13M 0.000 0.000 0 0 0 0 x25comms_mcp
304123 acard 0.9 966K 13M 0.001 0.003 0 0 0 0 tcpcomms
304178 ora817 0.0 598K 1.8G 0.000 0.000 0 0 0 0 oracle
304191 acard 0.0 417K 14M 0.000 0.000 0 0 0 0 epayint
304211 acard 0.0 237K 12M 0.000 0.000 0 0 0 0 hsmcomms_mcp
304232 acard 0.0 958K 13M 0.000 0.000 0 0 0 0 msglogger_mcp
304292 acard 0.0 4.6M 18M 0.000 0.000 0 0 0 0 atmi00
304358 ora817 0.0 991K 1.8G 0.000 0.000 0 0 0 0 oracle
304457 ora817 0.0 2.3M 1.8G 0.000 0.000 0 0 0 0 oracle
304462 ora817 0.0 991K 1.8G 0.000 0.000 0 0 0 0 oracle
304478 acard 0.0 393K 12M 0.000 0.000 0 0 0 0 timer00
304540 acard 0.0 1.5M 14M 0.000 0.000 0 0 0 0 hsmcomms_int
304585 acard 0.0 1.1M 14M 0.000 0.000 0 0 0 0 visa2_int
304600 acard 0.0 376K 12M 0.000 0.000 0 0 0 0 ppp2_3
304689 ora817 0.0 876K 1.8G 0.000 0.000 0 0 0 0 oracle
304731 acard 0.0 884K 13M 0.000 0.000 0 0 0 0 crout00
439262 acard 0.0 638K 13M 0.000 0.000 0 0 0 0 mcp
308235 ora817 0.0 172K 1.8G 0.000 0.000 0 0 0 0 oracle
441108 root 0.0 0K 2.2M 0.000 0.000 0 0 0 0 nfsiod
378183 root 0.0 196K 2.1M 0.000 0.000 0 0 0 0 sleep
247172 acard 0.0 1.3M 14M 0.000 0.000 0 0 0 0 8583pos_int
248461 ora817 0.0 253K 1.8G 0.000 0.000 0 0 0 0 oracle
316308 ora817 0.0 7.3M 1.8G 0.000 0.000 0 0 0 0 oracle
447977 ora817 3.6 2.9M 1.8G 0.003 0.000 0 0 0 0 oracle
320043 root 0.0 16K 2.4M 0.000 0.000 0 0 0 0 telnetd
320427 root 0.0 16K 3.1M 0.000 0.000 0 0 0 0 bash
320920 ora817 0.0 868K 20M 0.000 0.000 0 0 0 0 tnslsnr
257527 ora817 0.0 221K 1.8G 0.000 0.000 0 0 0 0 oracle
258602 ora817 0.0 1.0M 1.8G 0.000 0.000 0 0 0 0 oracle
326658 acard 0.0 368K 12M 0.000 0.000 0 0 0 0 ppp2_3
327344 ora817 0.0 270K 1.8G 0.000 0.000 0 0 0 0 oracle
327473 root 0.0 73K 2.4M 0.000 0.000 0 0 0 0 telnetd

# DISK Statistics
#DSK NAME B/T/L R/S RKB/S W/S WKB/S AVS AVW ACTQ WTQ %BSY
0 dsk4 1/0/0 102 3955 2 31 1.14 0.98 0.12 0.00 11.05
1 dsk5 1/2/0 0 31 1 61 2.22 0.00 0.00 0.00 0.37
2 dsk6 1/4/0 0 0 1 5 0.32 0.00 0.00 0.00 0.04
3 cdrom0 2/0/0 0 0 0 0 0.00 0.00 0.00 0.00 0.00

# CPU SUMMARY
# USER SYS IDLE WAIT INTR SYSC CS RUNQ AVG5 AVG30 AVG60 FORK VFORK
2 1 96 0 145 2690 840 0 0.24 0.12 0.09 0.22 0.00
# SINGLE CPU STATISTICS
# CPU USER SYS IDLE WAIT
0 2 1 96 0
1 3 1 97 0
9 REPLIES 9
Venkatesh BL
Honored Contributor

Re: collect error?

What is the OS and patch version?. There were some CPU related fixes that had gone into 'collect', but I don't remember seeing any disk related changes. Anyway, you can try out the latest collect CSP by logging a call with HP support.

Did you try running 'iostat' at the same instance?.
Nickolay
Occasional Advisor

Re: collect error?

My version is Compaq Tru64 UNIX V5.1A (Rev. 1885).
Venkatesh BL
Honored Contributor

Re: collect error?

Did you check the 'iostat' output?

Was there any cron job scheduled to running during that time?
Nickolay
Occasional Advisor

Re: collect error?

I got statistics by iostat command.
Values in "bps" column iostat command same as in collect statistic.

I think that in this 5 min starts and ends processes that not listed in collect. This processes works with disks.
I'll check it.
Venkatesh BL
Honored Contributor

Re: collect error?

What you said could really be true. Is there anything in the cron jobs that could be the culprit?
Nickolay
Occasional Advisor

Re: collect error?

At 04:00 I analyze oracle indexes, after it I think oracle reloads all used indexes into buffer memory.
Venkatesh BL
Honored Contributor

Re: collect error?

Were you able to confirm your findings?
Nickolay
Occasional Advisor

Re: collect error?

High load begins after analyze index. What ORACLE do I not see yet.
Nickolay
Occasional Advisor

Re: collect error?

Now I see that 3 days %BSY about 15% :(
There are my "DISK Statistics":
#DSK NAME B/T/L R/S RKB/S W/S WKB/S AVS AVW ACTQ WTQ %BSY
0 dsk4 1/0/0 108 4300 10 103 1.52 0.00 0.18 0.00 14.69

RKB/S + WKB/S = 4300 + 103 = 4403 - Kbytes transfered by disk dsk4.
But "Process Statistics" I see that only 18 blocks reads. How it can be (4403Kb != 18 blocks)?

On weekends must not be any activity. All other disk load about 0-1%.