linux-kernel.vger.kernel.org archive mirror
 help / color / mirror / Atom feed
* Long pauses (IO?) whilst ripping DVDs
@ 2004-01-03  6:24 Martin J. Bligh
  2004-01-03 12:26 ` Jens Axboe
  0 siblings, 1 reply; 5+ messages in thread
From: Martin J. Bligh @ 2004-01-03  6:24 UTC (permalink / raw)
  To: linux-kernel

Start transcode in one window, doing something like:
"transcode -i /dev/hdc -x dvd -U file_name -y divx4"
on a DVD ... probably pretty CPU intensive as well as IO.

Now do ls in another window ... hangs for about 5 seconds before
giving any output ;-( Anyone else seeing that? I do get a lot of
"*** libdvdread: CHECK_VALUE failed in nav_read.c:202 ***"
messages as well ... but I always seem to get those from DVD stuff.

All IDE, 2.6.0-rc1.

M.




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

* Re: Long pauses (IO?) whilst ripping DVDs
  2004-01-03  6:24 Long pauses (IO?) whilst ripping DVDs Martin J. Bligh
@ 2004-01-03 12:26 ` Jens Axboe
  2004-01-03 18:27   ` Martin J. Bligh
  2004-01-03 19:53   ` Martin J. Bligh
  0 siblings, 2 replies; 5+ messages in thread
From: Jens Axboe @ 2004-01-03 12:26 UTC (permalink / raw)
  To: Martin J. Bligh; +Cc: linux-kernel

On Fri, Jan 02 2004, Martin J. Bligh wrote:
> Start transcode in one window, doing something like:
> "transcode -i /dev/hdc -x dvd -U file_name -y divx4"
> on a DVD ... probably pretty CPU intensive as well as IO.
>
> Now do ls in another window ... hangs for about 5 seconds before
> giving any output ;-( Anyone else seeing that? I do get a lot of
> "*** libdvdread: CHECK_VALUE failed in nav_read.c:202 ***"
> messages as well ... but I always seem to get those from DVD stuff.

DMA or PIO? vmstat info would be very handy here.

-- 
Jens Axboe


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

* Re: Long pauses (IO?) whilst ripping DVDs
  2004-01-03 12:26 ` Jens Axboe
@ 2004-01-03 18:27   ` Martin J. Bligh
  2004-01-04 12:22     ` Jens Axboe
  2004-01-03 19:53   ` Martin J. Bligh
  1 sibling, 1 reply; 5+ messages in thread
From: Martin J. Bligh @ 2004-01-03 18:27 UTC (permalink / raw)
  To: Jens Axboe; +Cc: linux-kernel



--Jens Axboe <axboe@suse.de> wrote (on Saturday, January 03, 2004 13:26:14 +0100):

> On Fri, Jan 02 2004, Martin J. Bligh wrote:
>> Start transcode in one window, doing something like:
>> "transcode -i /dev/hdc -x dvd -U file_name -y divx4"
>> on a DVD ... probably pretty CPU intensive as well as IO.
>> 
>> Now do ls in another window ... hangs for about 5 seconds before
>> giving any output ;-( Anyone else seeing that? I do get a lot of
>> "*** libdvdread: CHECK_VALUE failed in nav_read.c:202 ***"
>> messages as well ... but I always seem to get those from DVD stuff.
> 
> DMA or PIO? vmstat info would be very handy here.
> 
> -- 
> Jens Axboe
> 
> 

OK, now I'm really confused ... sometimes it happens. sometimes it doesn't
with no apparent rhyme or reason. You're welcome to the data I have though.

titus:~# hdparm /dev/hda                   (the hard disk)

/dev/hda:
 multcount    = 16 (on)
 I/O support  =  0 (default 16-bit)
 unmaskirq    =  0 (off)
 using_dma    =  1 (on)
 keepsettings =  0 (off)
 nowerr       =  0 (off)
 readonly     =  0 (off)
 readahead    = 256 (on)
 geometry     = 58168/16/63, sectors = 58633344, start = 0
 busstate     =  1 (on)

titus:~# hdparm /dev/hdc                    (the DVD drive)

/dev/hdc:
 HDIO_GET_MULTCOUNT failed: Invalid argument
 I/O support  =  0 (default 16-bit)
 unmaskirq    =  0 (off)
 using_dma    =  1 (on)
 keepsettings =  0 (off)
 HDIO_GET_NOWERR failed: Invalid argument
 readonly     =  1 (on)
 readahead    =  8 (on)
 HDIO_GETGEO failed: Invalid argument
 busstate     =  1 (on)

readahead was 256 on the DVD last night when I was having problems, 
and ls -l on the same directory was repeatedly hanging ... now seems 
to be just on new directories, that it'd have to go to disk for, presumably.

Switched it back to 256 again ... get a 12s hang doing an ls -l on
a dir with only 10 entries in it ... hang is about 120s on a directory
with 50 entries ;-(

Switch it back to 8 ... can now do an ls -l of a directory with 7000
entries in < 0.5s.

Switch it back to 256 again ... all seems to be fine again ... WTF?
MemFree:        115840 kB .... wait until 

(readahed = 8) 

$ vmstat 1
   procs                      memory      swap          io     system      cpu
 r  b  w   swpd   free   buff  cache   si   so    bi    bo   in    cs us sy id
 3  2  0      0   2792 188780 119180    0    0   153   192   41   372  7  2 90
 1  2  0      0   3496 188036 119200    0    0  1964     0 1312  1183 33 67  0
 2  2  0      0   3624 187624 119500    0    0  1640     0 1232  1161 33 67  0
 1  2  0      0   3560 186960 120212    0    0  1800     0 1271  1089 50 50  0
 0  3  0      0   2920 186640 120944    0    0  2164   884 1280  1550 40 60  0
 1  2  0      0   3496 185140 121864    0    0  2176     0 1376  1701 40 60  0
 3  2  0      0   2856 184184 123504    0    0  2500     0 1475  2908 91  9  0
 2  0  0      0   3496 183584 123580    0    0   660     0 1184  8298 95  5  0
 5  0  0      0   3048 183972 123692    0    0   388     0 1153 10120 96  4  0
 3  0  0      0   4008 182996 123684    0    0   384  1176 1115  9725 96  4  0
 3  0  0      0   3496 183384 123796    0    0   392     0 1132 10113 96  4  0
 3  0  0      0   2984 183768 123932    0    0   384     0 1113  9185 96  4  0
 3  0  0      0   3048 184100 123612    0    0   772     0 1233 10756 94  6  0
 4  0  0      0   2856 184100 123752    0    0     0   528 1043  8400 97  3  0
 3  0  0      0   3496 184080 123176    0    0   800   136 1223 10604 95  5  0
 3  0  0      0   3368 184080 123312    0    0     0     0 1049  8288 97  3  0
 4  1  0      0   3368 184344 123008    0    0   720     0 1234 10641 95  5  0
 3  0  0      0   3176 184408 123168    0    0    64     0 1042  7812 97  3  0
 4  1  0      0   3496 184500 122676    0    0   516     0 1184 10431 96  4  0
 3  0  0      0   3240 184752 122784    0    0   252   656 1095  9401 96  4  0
 3  0  0      0   3496 184720 122464    0    0   392     0 1107  8434 97  3  0
 3  0  0      0   3048 185112 122588    0    0   396     0 1130  8928 95  5  0
 6  1  0      0   3432 185052 122312    0    0   420     0 1158 10356 96  4  0
 3  1  1      0   4520 184800 121368    0    0  1892   620 1133 10286 94  6  0
 0  3  0      0   4136 184348 122292    0    0  2744     4 1375  6224 84 16  0
 1  2  0      0   3176 184964 122616    0    0  1880     0 1280  1539 60 40  0
 0  3  1      0   3240 184824 122696    0    0  1424  5792 1489  2246 20 80  0
 0  3  1      0   3240 184932 122584    0    0   852  5332 1436  1998 23 77  0
 3  0  0      0   3432 184672 122672    0    0   588  2656 1306  3159 85 15  0
 3  0  0      0   2856 185060 122812    0    0   388     0 1129  9336 96  4  0
 3  0  0      0   3240 184664 122864    0    0   384     0 1115  9979 95  5  0
 3  0  0      0   3560 184184 122992    0    0   392   520 1123  9561 96  4  0
 4  0  0      0   3112 184568 123120    0    0   384     0 1150 11106 94  6  0
 4  0  0      0   3112 184548 123148    0    0   752     4 1230 10672 95  5  0
 3  1  0      0   3624 183996 123164    0    0   256     0 1088 10789 95  5  0
 3  0  0      0   2920 184496 123316    0    0   500   456 1165  8543 95  5  0
 3  0  0      0   3304 184056 123416    0    0   388     0 1132  8946 95  5  0
 2  0  0      0   3624 183640 123460    0    0   388     0 1128 10046 95  5  0
 4  0  1      0   3176 184028 123588    0    0   388   608 1157  9940 96  4  0
 3  0  0      0   3560 183576 123684    0    0   392     0 1123 10000 96  4  0
 3  0  0      0   2920 183956 123924    0    0   380     0 1146 10138 96  4  0
 4  0  0      0   3368 183528 123944    0    0   392     0 1126  9227 95  5  0
 4  0  0      0   2856 183916 124068    0    0   384   540 1166  9627 95  5  0
 3  0  0      0   3176 183480 124140    0    0   392     0 1153  9692 95  5  0
 5  0  0      0   3176 183696 123940    0    0   776     0 1134 10131 95  5  0
 1  2  0      0   3176 184420 123296    0    0  1936  1620 1132  9710 89 11  0
 1  2  0      0   2984 185024 122856    0    0  1008  3924 1367  1899 22 78  0
 0  3  0      0   3112 184808 122996    0    0   952  4156 1376  1704 26 74  0
 0  3  1      0   3048 185128 122752    0    0   964  2924 1281  1476 25 75  0
 0  3  0      0   3048 185304 122572    0    0   952  3140 1305  1461 29 71  0
 1  2  1      0   3624 185124 122124    0    0  1368  3212 1320  1888 31 69  0
 3  2  0      0   3496 185576 121740    0    0   860  4124 1361  1962 58 42  0
 3  1  0      0   3624 185488 121716    0    0   632     0 1196  9820 95  5  0
 3  0  0      0   3432 185640 121824    0    0   152     0 1098 10373 96  4  0
 3  0  0      0   3432 185772 121696    0    0   776     0 1208 11045 95  5  0
 3  0  0      0   2920 186160 121852    0    0   388     0 1149  8283 95  5  0
 3  0  0      0   3240 185860 121780    0    0   388   672 1119  9354 95  5  0
 3  1  0      0   3624 185600 121672    0    0   388   740 1276  8994 97  3  0
 4  0  0      0   3112 186012 121788    0    0   388     0 1107  9357 95  5  0
 6  0  0      0   2984 186072 121900    0    0    60   400 1080  9122 97  3  0
 5  0  0      0   3496 185712 121744    0    0   232     0 1067  8493 96  4  0
 4  0  0      0   3368 186020 121568    0    0   908     0 1259 10349 95  5  0
 4  1  0      0   3304 185996 121608    0    0   772     0 1281 10722 95  5  0
 5  0  0      0   3176 186000 121720    0    0     0   520 1050  9297 96  4  0
 4  0  0      0   3240 186416 121308    0    0   772     0 1253 10688 96  4  0
 4  0  0      0   3112 186416 121432    0    0     0     0 1062  9769 96  4  0
 5  0  0      0   3368 186216 121324    0    0   388     0 1122  6861 96  4  0
 6  0  0      0   2856 186604 121428    0    0   392     0 1138 10040 96  4  0
 4  2  0      0   3176 186516 121260    0    0   808   676 1078  9670 95  5  0
 0  3  0      0   3048 187040 120912    0    0   928  2284 1217  7653 84 16  0
 0  3  0      0   3560 187020 120284    0    0  1424  3204 1324  1822 27 73  0
 1  2  1      0   3304 187328 120332    0    0  1028  2520 1269  1466 25 75  0
 1  2  1      0   2984 187580 120364    0    0  1016  2960 1300  1444 23 77  0
 1  2  0      0   3560 187112 120236    0    0  1024  2728 1282  1385 15 85  0
 1  2  0      0   3432 187240 120244    0    0  1140  3412 1331  1743 25 75  0
 1  2  1      0   3880 186724 120288    0    0  1412  4004 1384  2394 20 80  0
 3  0  0      0   3176 187280 120464    0    0   464  1764 1289  4707 89 11  0
 3  0  0      0   4136 186360 120400    0    0   376     0 1102  7748 98  2  0
 4  0  0      0   3624 186764 120532    0    0   400   376 1161  9561 96  4  0

(readahead = 256) with memory still free

 2  0  0      0  85440 138612  84968    0    0   384     0 1022  8655 96  4  0
 2  0  0      0  84800 139124  85072    0    0   512   484 1023  9991 95  5  0
 2  0  0      0  84416 139380  85192    0    0   256   164 1271  8273 96  4  0
 2  0  0      0  83904 139764  85300    0    0   384     0 1231  9251 94  6  0
 2  0  0      0  83256 140148  85408    0    0   384     0 1119  8471 96  4  0
 2  1  0      0  82488 140916  85544    0    0   768     0 1074  9947 96  4  0
 1  0  0      0  82424 140916  85660    0    0     0     0 1023  8900 96  4  0
 2  1  0      0  81528 141684  85780    0    0   768   632 1027  9503 96  4  0
 1  0  0      0  81400 141684  85924    0    0     0     0 1018  8794 97  3  0
 2  0  0      0  80896 142068  86032    0    0   384     0 1027  8654 95  5  0
 4  0  0      0  80312 142452  86124    0    0   384     0 1039 12412 90 10  0
 2  0  0      0  79736 142964  86236    0    0   512    20 1030  8278 96  4  0
 1  0  0      0  79224 143348  86360    0    0   384   640 1026  8548 95  5  0
 2  0  0      0  78776 143732  86468    0    0   384     0 1042  9396 96  4  0
 2  0  0      0  78264 144116  86588    0    0   384     0 1029  8430 96  4  0
 2  1  0      0  77752 144500  86692    0    0   384     0 1008  8944 95  5  0
 2  0  0      0  77240 144884  86836    0    0   384     0 1023  8657 96  4  0
 1  0  0      0  76728 145268  86936    0    0   384   644 1186  7930 96  4  0
 2  1  0      0  76280 145652  87040    0    0   384     0 1204  8857 95  5  0
 1  0  0      0  74808 146036  87164    0    0   384     0 1064  8632 96  4  0
 2  0  0      0  75512 146036  87260    0    0     0     0 1185  8402 96  4  0
 2  0  0      0  74112 146804  87356    0    0   768     0 1088  7053 97  3  0
 2  0  0      0  74048 146804  87424    0    0     0   552 1143  5881 96  4  0
 2  0  0      0  73536 147188  87488    0    0   384     0 1124  4954 98  2  0
 2  0  0      0  73088 147572  87600    0    0   384     0 1075  8310 96  4  0
 3  0  0      0  73024 147572  87628    0    0     0     0 1244  2654 98  2  0
 2  0  0      0  72960 147572  87700    0    0     0     0 1082  5514 98  2  0
 2  0  0      0  72128 148340  87800    0    0   768   404 1025  8600 95  5  0
 2  0  0      0  72064 148340  87836    0    0     0     0 1231  1741 99  1  0
 2  0  0      0  72000 148340  87904    0    0     0     0 1194  6448 97  3  0
 2  0  0      0  72000 148340  87912    0    0     0     0 1264  1133 99  1  0
 2  0  0      0  71560 148724  87996    0    0   384     0 1022  7627 96  4  0
 3  0  0      0  71560 149108  88116    0    0   384   332 1096  9065 96  4  0
 1  0  0      0  71112 149492  88240    0    0   384     0 1119  8200 96  4  0
 1  0  0      0  70728 149876  88344    0    0   384     0 1075 11339 92  8  0
 3  0  0      0  70280 150260  88464    0    0   384   400 1146  8853 95  5  0
 1  0  0      0  69704 150644  88612    0    0   384     0 1032  8210 96  4  0
 2  0  0      0  69256 151028  88708    0    0   384   260 1074  8762 96  4  0
 1  1  0      0  68736 151412  88848    0    0   384     0 1014  8787 96  4  0
 2  0  0      0  68224 151796  88944    0    0   384     0 1023  8786 96  4  0
 3  1  0      0  67584 152308  89068    0    0   512     0 1042  9217 96  4  0
 2  0  0      0  67072 152692  89216    0    0   384     0 1014  8435 95  5  0
 2  0  0      0  67008 152692  89300    0    0     0   656 1028  9124 96  4  0
 1  1  0      0  66112 153460  89428    0    0   768     0 1200  8812 96  4  0
 2  0  0      0  65800 153460  89536    0    0     0     0 1167  8550 96  4  0
 3  0  0      0  65352 153844  89612    0    0   384    36 1181  7100 95  5  0
(at this point we have about 60MB free / 512MB, and it seems to start writing)

 2  0  0      0  64448 154236  89720    0    0   388  4856 1331  8060 81 19  0
 2  0  0      0  63936 154620  89824    0    0   384  5000 1389  8470 84 16  0
 3  0  1      0  63424 155016  89920    0    0   384  4732 1375  8892 85 15  0
 4  0  0      0  62912 155404  90012    0    0   384  5016 1383  8916 83 17  0
 3  0  0      0  62848 155412  90116    0    0     0  5248 1417  9010 83 17  0
 2  0  1      0  62336 155812  90220    0    0   384  4628 1409  8710 86 14  0
 4  0  0      0  61824 156196  90320    0    0   384  4764 1389  9635 83 17  0
 1  1  1      0  61184 156580  90416    0    0   384  4540 1373  8158 86 14  0
 2  0  0      0  60800 156968  90516    0    0   384  4524 1410  8797 86 14  0
 3  0  0      0  60736 156980  90604    0    0     0  3948 1494 11589 83 17  0
 2  0  1      0  60160 157368  90704    0    0   384  4376 1451  8214 86 14  0
 3  0  1      0  59704 157772  90796    0    0   384  4680 1394  8962 84 16  0
 3  0  1      0  59256 158164  90908    0    0   384  4672 1372  9595 85 15  0
 2  0  0      0  58744 158548  91008    0    0   384  4028 1324  8525 86 14  0
 2  0  0      0  58296 158936  91120    0    0   384  4780 1378  8289 86 14  0
 3  0  0      0  58168 158936  91216    0    0     0  4764 1384  8780 85 15  0
 5  1  0      0  57336 159704  91312    0    0   768  4980 1425  9424 83 17  0
 2  0  0      0  57208 159736  91420    0    0     0  4460 1363  8765 85 15  0
 2  0  0      0  56704 160120  91528    0    0   384  4688 1374  8606 84 16  0
 2  0  0      0  56192 160508  91632    0    0   384  4744 1412  8744 84 16  0
 3  1  0      0  55744 160896  91716    0    0   384  4820 1391  9276 86 14  0
 2  0  1      0  55232 161284  91832    0    0   384  4156 1544  7961 86 14  0
(but after a while it goes back to)
 2  0  0      0  11000 194376 102172    0    0   512     0 1023  9284 96  4  0
 2  0  0      0  10488 194760 102304    0    0   384   604 1032  8675 97  3  0
 2  0  0      0   9968 195144 102420    0    0   384     0 1025  9285 95  5  0
 1  0  0      0   9460 195528 102524    0    0   384     0 1262  8794 95  5  0
 2  0  0      0   8940 195912 102640    0    0   384     0 1017  9205 96  4  0
 1  0  0      0   8540 196168 102772    0    0   256     0 1010  8639 97  3  0
 3  0  0      0   8040 196552 102868    0    0   384   620 1045  8934 96  4  0
 2  0  0      0   7368 197064 103012    0    0   512   164 1020  8933 95  5  0
 1  0  0      0   6888 197448 103100    0    0   384     0 1084  8786 96  4  0
 1  0  0      0   6356 197832 103232    0    0   384     0 1076  7888 96  4  0
 1  0  0      0   5868 198216 103328    0    0   384     0 1012  9388 97  3  0
 1  0  0      0   5344 198600 103456    0    0   384   448 1031  8823 96  4  0
 2  1  0      0   4824 198984 103564    0    0   384     0 1011  8791 97  3  0
 1  0  0      0   4308 199368 103684    0    0   384     0 1011  8812 95  5  0
 4  1  0      0   3792 199752 103796    0    0   384     0 1027  9274 96  4  0
 2  0  0      0   3284 200136 103904    0    0   384     0 1026 15218 92  8  0
 1  0  0      0   3164 200136 104024    0    0     0   624 1017  8782 97  3  0
 2  1  0      0   3296 200612 103460    0    0   768    96 1040  8866 96  4  0
 2  0  0      0   3188 200612 103584    0    0     0     0 1019  9042 95  5  0
 1  0  0      0   4176 199820 103344    0    0   384     0 1011  8218 96  4  0
 1  0  0      0   3728 200204 103444    0    0   384     0 1029  9579 95  5  0
 2  0  0      0   3156 200588 103588    0    0   384   660 1041  9004 96  4  0
 2  0  0      0   3216 201356 102808    0    0   768     0 1013  9803 95  5  0
 2  0  0      0   3088 201356 102932    0    0     0     0 1027  9398 95  5  0
 2  0  0      0   3160 202124 102092    0    0   768     0 1043  9856 95  5  0
 3  0  0      0   3536 202508 101252    0    0   384     0 1036  9931 96  4  0
 1  0  0      0   3032 202892 101420    0    0   384   680 1033  9629 95  5  0
 3  0  0      0   3336 203300 100404    0    0   408     0 1043  9264 96  4  0
 1  0  0      0   3592 203732  99660    0    0   432     0 1023  8007 96  4  0
 1  0  0      0   3272 204116  99792    0    0   384     0 1018  9378 96  4  0
 1  0  0      0   3528 204500  99072    0    0   384     0 1021  9257 96  4  0
 1  0  0      0   3080 204884  99184    0    0   384   672 1023  9892 95  5  0
 1  0  0      0   3592 205264  98204    0    0   388     0 1013  9243 96  4  0
 2  0  0      0   3148 205648  98324    0    0   384     0 1142 15543 91  9  0
 1  0  0      0   3592 206160  97332    0    0   512     0 1134  8731 94  6  0
 3  0  0      0   3144 206544  97452    0    0   384     0 1061 10026 96  4  0
 1  0  0      0   3600 206928  96544    0    0   384   672 1018  9148 95  5  0
 2  0  0      0   3152 207312  96656    0    0   384     0 1022 10067 95  5  0
 1  0  0      0   3600 207692  95772    0    0   384     0 1028  8677 96  4  0
 2  0  0      0   3152 208076  95880    0    0   384     0 1025 10058 96  4  0
 2  0  0      0   3600 208460  94980    0    0   384     0 1033  8645 95  5  0
 3  1  0      0   3656 209228  94200    0    0   768   680 1023  9918 95  5  0
 1  0  0      0   3528 209228  94324    0    0     0   140 1012  8794 97  3  0
 1  0  0      0   3080 209612  94444    0    0   384     0 1010  8892 96  4  0
 1  0  0      0   3464 209996  93516    0    0   384     0 1016  9801 96  4  0
 2  0  0      0   3084 210380  93636    0    0   384     0 1029  8679 95  5  0
 2  0  0      0   3528 210764  92740    0    0   384   540 1035  9558 95  5  0
 1  0  0      0   3080 211148  92848    0    0   384     0 1016  8665 96  4  0
 2  0  0      0   3464 211532  91928    0    0   384     0 1019  9133 96  4  0
 1  0  0      0   3080 211916  92040    0    0   384     0 1028  9041 94  6  0
 1  0  0      0   3528 212300  91120    0    0   384     0 1018  8240 96  4  0
 2  0  0      0   3080 212684  91244    0    0   384   648 1027  9418 95  5  0
 2  0  0      0   3592 213068  90300    0    0   384    48 1042 15802 90 10  0
 2  1  0      0   3208 213452  90456    0    0   384     0 1016  9645 95  5  0
 1  0  0      0   3592 213836  89588    0    0   384     0 1021 10343 95  5  0
 3  0  0      0   3144 214220  89732    0    0   384     0 1016  9537 97  3  0
 1  0  0      0   3536 214604  88888    0    0   384   680 1018  9197 95  5  0
 2  0  0      0   3088 214988  89008    0    0   384     0 1015 10566 96  4  0
 1  0  0      0   3540 215372  88112    0    0   384     0 1031  9240 95  5  0
 1  0  0      0   3100 215756  88204    0    0   384     0 1172  9562 96  4  0
(now out of LowFree .... but doesn't seem to matter. Pattern is still the same)
 3  0  0      0   3220 227260  76680    0    0   384     0 1147  9552 95  5  0
 4  0  0      0   4240 226156  76628    0    0   384     0 1045 10659 95  5  0
 3  0  0      0   3856 226540  76732    0    0   384   612 1036  8594 96  4  0
 2  0  0      0   3472 226924  76852    0    0   384     0 1045  9164 95  5  0
 3  2  0      0   3600 226688  76880    0    0  1536     0 1035  9739 95  5  0
 2  1  0      0   3152 227132  76952    0    0  1280     0 1033 11718 94  6  0
 0  1  0      0   3600 226552  76944    0    0  2304     0 1036  3210 81 19  0
 0  1  0      0   3280 227052  76884    0    0  2688   364 1040  1882 50 50  0
 4  1  0      0   3216 227076  76956    0    0   768     0 1062  6567 97  3  0
 3  0  0      0   3536 226692  76944    0    0   384     0 1039  8938 96  4  0
 2  1  0      0   3088 227076  77048    0    0   384     0 1039  9045 95  5  0
 2  0  0      0   3536 226556  77052    0    0   384     0 1034  9011 96  4  0
 4  1  0      0   3152 226940  77156    0    0   384   660 1069  9406 97  3  0
 1  0  0      0   3600 226460  77112    0    0   512     0 1028  8476 95  5  0
 1  0  0      0   3216 226844  77208    0    0   384     0 1019  9814 95  5  0
 1  0  0      0   3792 226140  77224    0    0   384     0 1024  8758 96  4  0
 3  0  0      0   3344 226524  77340    0    0   384     0 1045  9707 95  5  0
 1  1  0      0   3280 226636  77284    0    0   768   660 1037 10008 96  4  0
 4  0  0      0   3152 226636  77416    0    0     0     0 1043  9456 96  4  0
 2  0  0      0   3152 226600  77444    0    0   768     0 1028  9680 95  5  0
 2  1  0      0   3600 226064  77460    0    0   384     0 1022 10198 95  5  0
 1  0  0      0   3216 226448  77588    0    0   384     0 1025  9486 96  4  0
 1  1  0      0   3600 225812  77736    0    0   384   692 1024  9339 94  6  0
 1  0  0      0   3216 226196  77828    0    0   384     0 1019  9203 96  4  0
 3  0  0      0   3280 226048  77900    0    0  1536     0 1028  9780 94  6  0
 1  2  0      0   3600 225704  77864    0    0  2688     0 1029 12424 93  7  0
 0  1  0      0   3344 226020  77864    0    0  1152     0 1034  3164 88 12  0
 0  1  0      0   3600 226092  77464    0    0  2688   412 1062  1879 50 50  0
 1  0  0      0   3472 226092  77616    0    0     0     0 1025  4957 97  3  0
 2  1  0      0   3024 226476  77744    0    0   384     0 1031  8950 96  4  0
 2  0  0      0   3600 225900  77716    0    0   384     0 1046  9532 95  5  0
 2  0  0      0   3088 226284  77848    0    0   384     0 1030 10032 96  4  0
 1  0  0      0   3792 225556  77808    0    0   384     0 1029  8923 94  6  0
 3  0  0      0   3408 225940  77916    0    0   384   696 1059 10448 97  3  0
 1  0  0      0   2896 226324  78044    0    0   384     0 1025  9095 95  5  0
 2  0  0      0   4368 224960  77884    0    0   384     0 1019  9611 94  6  0
 1  0  0      0   3920 225344  78000    0    0   384     0 1021  9830 95  5  0
 3  0  0      0   4176 224920  78008    0    0   384   584 1037  8197 95  5  0
 1  0  0      0   3792 225304  78120    0    0   384    32 1046  9387 96  4  0
 1  0  0      0   3216 225688  78228    0    0   384     0 1040  8434 95  5  0
 1  0  0      0   3216 225688  78356    0    0     0     0 1027  8661 96  4  0
 1  0  0      0   3664 225160  78448    0    0   768     0 1017  9653 95  5  0
 2  0  0      0   3408 225160  78504    0    0     0   596 1072  6834 96  4  0
 2  0  0      0   3024 225544  78636    0    0   384     0 1024  8186 97  3  0
 2  1  0      0   3600 224856  78720    0    0  1152     0 1019  9628 95  5  0
 4  0  0      0   3280 225172  78832    0    0  2048     0 1039 10179 94  6  0
 0  2  0      0   3280 225100  78852    0    0  1920     0 1094  9061 92  8  0
 0  1  0      0   2896 225544  78788    0    0  1536   424 1095  1454 57 43  0
 3  0  0      0   3088 224916  78496    0    0  1920     0 1098  2055 89  9  2
 1  0  0      0   3600 224916  78576    0    0     0     0 1077  3004 95  5  0
 2  0  0      0   3472 224916  78696    0    0     0     0 1020  8358 96  4  0
 1  0  0      0   3600 224840  78688    0    0   768   348 1024  9495 96  4  0
 2  0  0      0   3472 224840  78800    0    0     0     0 1017  8898 95  5  0
 2  0  0      0   3600 224796  78776    0    0   768   272 1035  9930 95  5  0
 3  0  0      0   3472 224796  78884    0    0     0     0 1022  8947 96  4  0


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

* Re: Long pauses (IO?) whilst ripping DVDs
  2004-01-03 12:26 ` Jens Axboe
  2004-01-03 18:27   ` Martin J. Bligh
@ 2004-01-03 19:53   ` Martin J. Bligh
  1 sibling, 0 replies; 5+ messages in thread
From: Martin J. Bligh @ 2004-01-03 19:53 UTC (permalink / raw)
  To: Jens Axboe; +Cc: linux-kernel

OK, here's a capture of data from when the system is being a little bit
slow to respond, though nothing as bad as I'd managed to recreate earlier.
There's a vmstat 5, mixed with a grab of some fields from /proc/meminfo,
and the dentry_cache from slabinfo (every 5 seconds).

M.

 3  0  0      0   3516 217260  93480    0    0   384   139 1017  9551 96  4  0
MemTotal:       513060 kB
MemFree:          3068 kB
Buffers:        217644 kB
Cached:          93616 kB
Active:         363024 kB
Inactive:       121000 kB
Dirty:            1256 kB
Slab:            20628 kB
dentry_cache        6969  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
 5  0  0      0   3516 216776  93956    0    0   487   142 1010  9285 96  4  0
MemTotal:       513060 kB
MemFree:          3132 kB
Buffers:        217160 kB
Cached:          94068 kB
Active:         361808 kB
Inactive:       122188 kB
Dirty:            1852 kB
Slab:            20588 kB
dentry_cache        6969  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
 6  0  0      0   3132 217912  93320    0    0   384    88 1012 10023 95  5  0
MemTotal:       513060 kB
MemFree:          3580 kB
Buffers:        217404 kB
Cached:          93312 kB
Active:         367352 kB
Inactive:       116136 kB
Dirty:            2480 kB
Slab:            20572 kB
dentry_cache        6969  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
 4  0  0      0   3580 217388  93420    0    0   384   146 1008  9426 97  3  0
MemTotal:       513060 kB
MemFree:          3132 kB
Buffers:        217772 kB
Cached:          93540 kB
Active:         366492 kB
Inactive:       117592 kB
Dirty:            3104 kB
Slab:            20508 kB
dentry_cache        6969  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
   procs                      memory      swap          io     system      cpu
 r  b  w   swpd   free   buff  cache   si   so    bi    bo   in    cs us sy id
 6  0  0      0   3068 217712  93684    0    0   384   263 1044  9347 96  4  0
MemTotal:       513060 kB
MemFree:          3452 kB
Buffers:        216740 kB
Cached:          94224 kB
Active:         364408 kB
Inactive:       119300 kB
Dirty:            3764 kB
Slab:            20472 kB
dentry_cache        7087  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
 3  0  0      0   3388 216740  94224    0    0   384   140 1008  9362 96  4  0
 7  0  0      0   3132 216672  94732    0    0   385   180 1035 10069 95  5  0
MemTotal:       513060 kB
MemFree:          3132 kB
Buffers:        216672 kB
Cached:          94740 kB
Active:         370508 kB
Inactive:       113648 kB
Dirty:             120 kB
Slab:            20432 kB
dentry_cache        7039  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
 7  0  0      0   3516 215996  94992    0    0   410   114 1047  9273 97  3  0
MemTotal:       513060 kB
MemFree:          3516 kB
Buffers:        215996 kB
Cached:          95000 kB
Active:         368980 kB
Inactive:       114760 kB
Dirty:             712 kB
Slab:            20416 kB
dentry_cache        7039  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
 5  0  0      0   3004 216720  94808    0    0   384   109 1047  8724 97  3  0
MemTotal:       513060 kB
MemFree:          3004 kB
Buffers:        216720 kB
Cached:          94812 kB
Active:         367984 kB
Inactive:       116328 kB
Dirty:            1280 kB
Slab:            20388 kB
dentry_cache        6991  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
 4  1  0      0   3580 215780  95168    0    0   385   141 1064  9814 95  5  0
MemTotal:       513060 kB
MemFree:          3580 kB
Buffers:        215780 kB
Cached:          95180 kB
Active:         373840 kB
Inactive:       109896 kB
Dirty:            1848 kB
Slab:            20344 kB
dentry_cache        6991  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
 3  0  0      0   3580 215240  95612    0    0   384   162 1088  9067 96  4  0
MemTotal:       513060 kB
MemFree:          3580 kB
Buffers:        215240 kB
Cached:          95640 kB
Active:         372108 kB
Inactive:       111524 kB
Dirty:            2396 kB
Slab:            20332 kB
dentry_cache        6981  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
 6  0  0      0   3132 215536  95956    0    0   384   142 1092  9009 96  4  0
MemTotal:       513060 kB
MemFree:          3132 kB
Buffers:        215536 kB
Cached:          95964 kB
Active:         371216 kB
Inactive:       113040 kB
Dirty:            2888 kB
Slab:            20328 kB
 4  1  0      0   3180 215376  96120    0    0   385   134 1120  8516 96  4  0
 7  0  0      0   3892 214932  95792    0    0   307   122 1133  9362 95  5  0
dentry_cache        7045  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
 3  0  0      0   3252 215608  95836    0    0   384   157 1090  9001 96  4  0
MemTotal:       513060 kB
MemFree:          3132 kB
Buffers:        215248 kB
Cached:          96364 kB
Active:         373324 kB
Inactive:       111048 kB
Dirty:            1372 kB
Slab:            20160 kB
dentry_cache        6986  13848    160   24    1 : tunables  240  120    0 : slabdata    577    577      0
 4  0  0      0   3132 215248  96364    0    0   486   121 1013  9666 96  4  0
MemTotal:       513060 kB
MemFree:          3580 kB
Buffers:        214292 kB
Cached:          96856 kB
Active:         371812 kB
Inactive:       112104 kB
Dirty:            1988 kB
Slab:            20132 kB
dentry_cache        6973  13824    160   24    1 : tunables  240  120    0 : slabdata    576    576      0
 4  0  0      0   3516 214292  96868    0    0   385   142 1016  9716 96  4  0
 5  0  0      0   3132 214212  97448    0    0   384    97 1012  9989 95  5  0
MemTotal:       513060 kB
MemFree:          3132 kB
Buffers:        214212 kB
Cached:          97448 kB
Active:         378272 kB
Inactive:       106156 kB
Dirty:            2596 kB
Slab:            20136 kB
dentry_cache        6973  13824    160   24    1 : tunables  240  120    0 : slabdata    576    576      0
 7  0  0      0   3516 213268  98032    0    0   384   122 1053  9592 96  4  0
MemTotal:       513060 kB
MemFree:          3068 kB
Buffers:        213652 kB
Cached:          98136 kB
Active:         376808 kB
Inactive:       107752 kB
Dirty:            3264 kB
Slab:            20084 kB
dentry_cache        6925  13824    160   24    1 : tunables  240  120    0 : slabdata    576    576      0
 4  0  0      0   3068 213220  98620    0    0   384   229 1011  9324 96  4  0
MemTotal:       513060 kB
MemFree:          3196 kB
Buffers:        213064 kB
Cached:          98668 kB
Active:         375136 kB
Inactive:       109364 kB
Dirty:             272 kB
Slab:            20056 kB
dentry_cache        6877  13824    160   24    1 : tunables  240  120    0 : slabdata    576    576      0
 5  0  0      0   2940 214224  97712    0    0   487    75 1015 10150 96  4  0
MemTotal:       513060 kB
MemFree:          3580 kB
Buffers:        213572 kB
Cached:          97676 kB
Active:         380592 kB
Inactive:       103428 kB
Dirty:             856 kB
Slab:            20048 kB
dentry_cache        6877  13824    160   24    1 : tunables  240  120    0 : slabdata    576    576      0
 5  0  0      0   4284 212984  97660    0    0   358   141 1011  9356 96  4  0
MemTotal:       513060 kB
MemFree:          3452 kB
Buffers:        213752 kB
Cached:          97768 kB
Active:         379736 kB
Inactive:       104556 kB
Dirty:            1516 kB
Slab:            20004 kB
dentry_cache        6829  13800    160   24    1 : tunables  240  120    0 : slabdata    575    575      0
 5  0  0      0   3132 213588  98224    0    0   486   133 1025  9466 97  3  0
MemTotal:       513060 kB
MemFree:          3004 kB
Buffers:        213596 kB
Cached:          98344 kB
Active:         378700 kB
Inactive:       106016 kB
Dirty:            2160 kB
Slab:            19972 kB
dentry_cache        6781  13800    160   24    1 : tunables  240  120    0 : slabdata    575    575      0
 3  0  0      0   3452 212884  98568    0    0   385   111 1034  9482 96  4  0
 5  1  0      0   3196 212700  99124    0    0   384   139 1011 10499 96  4  0
MemTotal:       513060 kB
MemFree:          3132 kB
Buffers:        212700 kB
Cached:          99124 kB
Active:         383052 kB
Inactive:       101552 kB
Dirty:            3236 kB
Slab:            19976 kB
dentry_cache        6733  13800    160   24    1 : tunables  240  120    0 : slabdata    575    575      0
   procs                      memory      swap          io     system      cpu
 r  b  w   swpd   free   buff  cache   si   so    bi    bo   in    cs us sy id
 4  0  0      0   3580 211712  99664    0    0   384   271 1057  9218 96  4  0
MemTotal:       513060 kB
MemFree:          3580 kB
Buffers:        211712 kB
Cached:          99676 kB
Active:         381532 kB
Inactive:       102636 kB
Dirty:             180 kB
Slab:            19904 kB
dentry_cache        6721  13800    160   24    1 : tunables  240  120    0 : slabdata    575    575      0
 5  0  0      0   3060 211684 100180    0    0   386   149 1010  9284 97  3  0
MemTotal:       513060 kB
MemFree:          3060 kB
Buffers:        211688 kB
Cached:         100180 kB
Active:         380560 kB
Inactive:       104176 kB
Dirty:             844 kB
Slab:            19912 kB
dentry_cache        6835  13800    160   24    1 : tunables  240  120    0 : slabdata    575    575      0
 4  0  0      0   3636 211812  99488    0    0   389   142 1009  9396 96  4  0
MemTotal:       513060 kB
MemFree:          3636 kB
Buffers:        211812 kB
Cached:          99504 kB
Active:         383504 kB
Inactive:       100596 kB
Dirty:            1452 kB
Slab:            19912 kB
dentry_cache        6835  13800    160   24    1 : tunables  240  120    0 : slabdata    575    575      0
 5  0  0      0   3812 211472  99664    0    0   307   117 1179  9565 95  5  0
MemTotal:       513060 kB
MemFree:          3812 kB
Buffers:        211472 kB
Cached:          99684 kB
Active:         385308 kB
Inactive:        98632 kB
Dirty:            1980 kB
Slab:            19976 kB
dentry_cache        6787  13800    160   24    1 : tunables  240  120    0 : slabdata    575    575      0
 4  0  0      0   3396 212056  99884    0    0   461   118 1036  9283 96  4  0


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

* Re: Long pauses (IO?) whilst ripping DVDs
  2004-01-03 18:27   ` Martin J. Bligh
@ 2004-01-04 12:22     ` Jens Axboe
  0 siblings, 0 replies; 5+ messages in thread
From: Jens Axboe @ 2004-01-04 12:22 UTC (permalink / raw)
  To: Martin J. Bligh; +Cc: linux-kernel

On Sat, Jan 03 2004, Martin J. Bligh wrote:
> 
> 
> --Jens Axboe <axboe@suse.de> wrote (on Saturday, January 03, 2004 13:26:14 +0100):
> 
> > On Fri, Jan 02 2004, Martin J. Bligh wrote:
> >> Start transcode in one window, doing something like:
> >> "transcode -i /dev/hdc -x dvd -U file_name -y divx4"
> >> on a DVD ... probably pretty CPU intensive as well as IO.
> >> 
> >> Now do ls in another window ... hangs for about 5 seconds before
> >> giving any output ;-( Anyone else seeing that? I do get a lot of
> >> "*** libdvdread: CHECK_VALUE failed in nav_read.c:202 ***"
> >> messages as well ... but I always seem to get those from DVD stuff.
> > 
> > DMA or PIO? vmstat info would be very handy here.
> > 
> > -- 
> > Jens Axboe
> > 
> > 
> 
> OK, now I'm really confused ... sometimes it happens. sometimes it doesn't
> with no apparent rhyme or reason. You're welcome to the data I have though.

You have periods of excessive system usage, although DMA is enabled on
the drive. Depending on what transcode does, it might still be using pio
though. Any chance you can profile such a 'sy' peak so we can see what's
going on?

Looks odds, though. I'm inclined to guess this is a CPU scheduler
problem. Does booting with elevator=deadline change anything at all?

-- 
Jens Axboe


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

end of thread, other threads:[~2004-01-04 12:22 UTC | newest]

Thread overview: 5+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2004-01-03  6:24 Long pauses (IO?) whilst ripping DVDs Martin J. Bligh
2004-01-03 12:26 ` Jens Axboe
2004-01-03 18:27   ` Martin J. Bligh
2004-01-04 12:22     ` Jens Axboe
2004-01-03 19:53   ` Martin J. Bligh

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).