Page 1 of 2

Hi server load

Posted: 2011-02-01T11:27:13-07:00
by ecoverguru
Sorry for starting in a new thread, I thought it would be better to create a new discussing in other thread

So here is the issue

My old server was dual xeon 5660 (24 cores) and I had no problem with imagemagick 6.6.6-4

I got a new server dual xeon 5670 (24 cores) + 12 GB RAM with same version of imagemagick

Now I ran a small loadtest

The old server load 4.35 &
new server load 888..48

And ultimately became unstable and I had to reboot

I am not linux guy, and I am having someone else to manage my server, but they are and even the datacenter guys are unable to solve the problem.

Is it possible for you to log in to my server and solve the issue? I understand this would take your time and am ready to compensate it.

Also as per suggestion by "magick"

I installed new version 6.6.7-4 and tried with / without OpenMP and also added <policy domain="resource" name="thread" value="2"/> to the policy.xml file

BUT still nothing helped..

Here is the Screenshot I took from WHM showing processes, and you can see the CPU load for these processes.

Image


I was just wondering, if there are any additional libraries affecting imagemagick causing this heavy server load?

Is problem somewhere else? cause this is brand new server and the first thing we did is install imagemagick and I started doing this test.




Thank you very much

Re: Hi server load

Posted: 2011-02-01T11:38:54-07:00
by magick
Post the output of this command:
  • convert -debug all logo: null:

Re: Hi server load

Posted: 2011-02-01T11:56:14-07:00
by ecoverguru
Here it is.
root@server786 [~]# convert -debug all logo: null:
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Configure convert[27279]: utility.c/ExpandFilenames/905/Configure
Command line: convert {-debug} {all} {logo:} {null:}
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Policy convert[27279]: policy.c/IsRightsAuthorized/485/Policy
Domain: Coder; rights=Read; pattern="LOGO" ...
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Cache convert[27279]: cache.c/DestroyPixelCache/1507/Cache
destroy
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Configure convert[27279]: configure.c/GetConfigureOptions/564/Configure
Searching for configure file: "/usr/local/share/ImageMagick-6.6.7/config/magic.xml"
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Configure convert[27279]: configure.c/GetConfigureOptions/564/Configure
Searching for configure file: "/usr/local/lib/ImageMagick-6.6.7/config/magic.xml"
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Configure convert[27279]: configure.c/GetConfigureOptions/564/Configure
Searching for configure file: "/usr/local/share/doc/ImageMagick-6.6.7/magic.xml"
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Configure convert[27279]: configure.c/GetConfigureOptions/564/Configure
Searching for configure file: "/usr/local/share/ImageMagick-6.6.7/magic.xml"
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Configure convert[27279]: configure.c/GetConfigureOptions/564/Configure
Searching for configure file: "/root/.magick/magic.xml"
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Configure convert[27279]: magic.c/LoadMagicList/678/Configure
Loading magic configure file "/usr/local/share/ImageMagick-6.6.7/config/magic.xml" ...
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Policy convert[27279]: policy.c/IsRightsAuthorized/485/Policy
Domain: Coder; rights=Read; pattern="GIF" ...
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Coder convert[27279]: gif.c/ReadGIFImage/1159/Coder
Reading GIF application extension
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Coder convert[27279]: gif.c/ReadGIFImage/1193/Coder
profile name=icc
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Resource convert[27279]: resource.c/AcquireMagickResource/262/Resource
Area: 3.072MB/3.072MB/3.1462GB
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Resource convert[27279]: resource.c/AcquireMagickResource/262/Resource
Memory: 3.072MB/2.93MiB/11.72GiB
2011-02-01T12:55:39-06:00 0:00.000 0.000u 6.6.7 Cache convert[27279]: cache.c/OpenPixelCache/4056/Cache
open LOGO[0] (heap memory, 640x480 2.93MiBB)
2011-02-01T12:55:39-06:00 0:00.010 0.010u 6.6.7 Policy convert[27279]: policy.c/IsRightsAuthorized/485/Policy
Domain: Coder; rights=Write; pattern="NULL" ...
2011-02-01T12:55:39-06:00 0:00.010 0.010u 6.6.7 Cache convert[27279]: cache.c/DestroyPixelCache/1507/Cache
destroy LOGO[0]
2011-02-01T12:55:39-06:00 0:00.010 0.010u 6.6.7 Resource convert[27279]: resource.c/RelinquishMagickResource/801/Resource
Memory: 3.072MB/0B/11.72GiB

Re: Hi server load

Posted: 2011-02-01T12:00:24-07:00
by magick
Post the output of this command:
  • convert -list configure

Re: Hi server load

Posted: 2011-02-01T12:02:45-07:00
by magick
Your command ran fast as expected. Try again but lets put a load on it:
  • convert -debug all logo: -resize 1000% null:
Post the output. Thanks.

Re: Hi server load

Posted: 2011-02-01T12:07:24-07:00
by ecoverguru
Here is the configuration output for convert -list configure .. i will run another test after this..
root@server786 [~]# convert -list configure

Path: /usr/local/lib/ImageMagick-6.6.7/config/configure.xml

Name Value
-------------------------------------------------------------------------------
CC gcc -std=gnu99 -std=gnu99
CFLAGS -fopenmp -g -O2 -Wall -pthread
CONFIGURE ./configure '--enable-shared'
COPYRIGHT Copyright (C) 1999-2011 ImageMagick Studio LLC
CPPFLAGS -I/usr/local/include/ImageMagick
CXX g++
CXXFLAGS -g -O2 -pthread
DEFS -DHAVE_CONFIG_H
DELEGATES fontconfig freetype jpeg jng png tiff x11 xml zlib
DISTCHECK_CONFIG_FLAGS --disable-deprecated --with-quantum-depth=16 --with-umem=no --with-autotrace=no --with-gslib=no --with-fontpath= --with-perl=no
EXEC-PREFIX /usr/local
FEATURES OpenMP
HOST x86_64-unknown-linux-gnu
LDFLAGS -L/usr/local/lib
LIB_VERSION 0x667
LIB_VERSION_NUMBER 6,6,7,4
LIBS -lMagickCore -ltiff -lfreetype -ljpeg -lpng -lfontconfig -lX11 -lxml2 -lz -lm -lgomp -lpthread
NAME ImageMagick
PCFLAGS -fopenmp
PREFIX /usr/local
QuantumDepth 16
RELEASE_DATE 2011-02-01
VERSION 6.6.7
WEBSITE http://www.imagemagick.org

Path: [built-in]

Name Value
-------------------------------------------------------------------------------
NAME ImageMagick

Re: Hi server load

Posted: 2011-02-01T12:09:35-07:00
by ecoverguru
Hello Magic, the command "convert -debug all logo: -resize 1000% null:" is just keep on going.. how do I copy and paste the output? should i break it ? and copy last parts?

Re: Hi server load

Posted: 2011-02-01T12:10:36-07:00
by ecoverguru
Ok, it stopped automatically.. and here is all i could copy from the text available on the screen
LOGO[0][1x480+5059+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+504+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+504+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5060+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+504+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+504+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5061+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+504+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+504+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5062+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+504+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+504+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5063+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+504+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+504+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5064+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5065+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5066+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5067+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5068+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5069+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:25-06:00 1:38.930 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:26-06:00 1:39.190 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+344+0]
2011-02-01T13:09:26-06:00 1:39.190 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+344+0]
2011-02-01T13:09:26-06:00 1:39.190 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5070+0]
2011-02-01T13:09:26-06:00 1:39.190 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+3460+0]
2011-02-01T13:09:26-06:00 1:39.190 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:26-06:00 1:39.190 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:26-06:00 1:39.190 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5071+0]
2011-02-01T13:09:26-06:00 1:39.190 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:26-06:00 1:39.190 3.540u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+505+0]
2011-02-01T13:09:26-06:00 1:39.190 3.540u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5072+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+531+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5330+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+531+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+531+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5331+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+531+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+531+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5332+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+531+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+531+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5333+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+531+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+531+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5334+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+532+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+532+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5335+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+532+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+532+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5336+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+532+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+532+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5337+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+532+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+532+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5338+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+532+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+532+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+5339+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+344+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+344+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+3461+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+344+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+344+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+3462+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+344+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+344+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+3463+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+344+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+344+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+3464+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+3465+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+3466+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+3467+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+3468+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+3469+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCachePixels/4782/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/ReadPixelCacheIndexes/4654/Cache
LOGO[0][4x480+345+0]
2011-02-01T13:09:26-06:00 1:39.200 3.550u 6.6.7 Cache convert[4433]: cache.c/WritePixelCachePixels/5518/Cache
LOGO[0][1x480+3470+0]
2011-02-01T13:09:26-06:00 1:39.330 5.010u 6.6.7 Resource convert[4433]: resource.c/AcquireMagickResource/262/Resource
Area: 245.8MB/245.8MB/3.1462GB
2011-02-01T13:09:26-06:00 1:39.450 5.010u 6.6.7 Resource convert[4433]: resource.c/AcquireMagickResource/262/Resource
Memory: 245.8MB/260.7MiB/11.72GiB
2011-02-01T13:09:26-06:00 1:39.450 5.010u 6.6.7 Cache convert[4433]: cache.c/OpenPixelCache/4056/Cache
open LOGO[0] (heap memory, 6400x4800 234.4MiBB)
2011-02-01T13:09:26-06:00 1:39.880 10.320u 6.6.7 Cache convert[4433]: cache.c/DestroyPixelCache/1507/Cache
destroy LOGO[0]
2011-02-01T13:09:26-06:00 1:39.880 10.340u 6.6.7 Resource convert[4433]: resource.c/RelinquishMagickResource/801/Resource
Memory: 24.58MB/237.3MiB/11.72GiB
2011-02-01T13:09:26-06:00 1:39.880 10.340u 6.6.7 Cache convert[4433]: cache.c/DestroyPixelCache/1507/Cache
destroy LOGO[0]
2011-02-01T13:09:26-06:00 1:39.890 10.340u 6.6.7 Resource convert[4433]: resource.c/RelinquishMagickResource/801/Resource
Memory: 3.072MB/234.4MiB/11.72GiB
2011-02-01T13:09:26-06:00 1:39.890 10.360u 6.6.7 Policy convert[4433]: policy.c/IsRightsAuthorized/485/Policy
Domain: Coder; rights=Write; pattern="NULL" ...
2011-02-01T13:09:26-06:00 1:39.890 10.360u 6.6.7 Cache convert[4433]: cache.c/DestroyPixelCache/1507/Cache
destroy LOGO[0]
2011-02-01T13:09:26-06:00 1:39.900 10.540u 6.6.7 Resource convert[4433]: resource.c/RelinquishMagickResource/801/Resource
Memory: 245.8MB/0B/11.72GiB

Re: Hi server load

Posted: 2011-02-01T12:14:35-07:00
by magick
Output the debugging to a file and post the first parts and the last parts and leave out the Cache statements in the middle.

Re: Hi server load

Posted: 2011-02-01T12:17:30-07:00
by ecoverguru
Just for your information,

When i try simple
exec("convert 7058_34_12_534.jpg output.jpg");
with load test it works fine.. no issues.. but when i try this actual command I need the load just shoots up
exec("convert 7058_34_12_534.jpg -crop 55x704+0+0 +repage -virtual-pixel transparent -matte +distort Perspective '0,0,0,0, 0,704,5,227, 55,0,12,6, 55,704,16,237' -sharpen 3x2 spine.png");
And this exact code works fine on my old server the problem is, I had to terminate old server as datacenter wants me to order new server to change the billing method... and unnecessarily got caught into this problem.. my entire project is based on around 10-12 imagemagick commands.. :(

Re: Hi server load

Posted: 2011-02-01T12:19:22-07:00
by ecoverguru
magick wrote:Output the debugging to a file and post the first parts and the last parts and leave out the Cache statements in the middle.
Sorry brother, I know very few command on linux using putty... so have no idea how to output it to file.. and open the file to copy the content. :(

if you tell me exact command to run I will do that now.. else I will have to create a ticket with server guys and not sure how long it will take to get response from them, I am sick of their service.

Re: Hi server load

Posted: 2011-02-01T12:24:53-07:00
by magick
Let's get timing of the command. Post the output of:
  • time convert 7058_34_12_534.jpg -crop 55x704+0+0 +repage -virtual-pixel transparent -matte +distort Perspective '0,0,0,0, 0,704,5,227, 55,0,12,6, 55,704,16,237' -sharpen 3x2 spine.png
The command runs in 0.12 seconds on our Linux host.

Re: Hi server load

Posted: 2011-02-01T12:30:17-07:00
by ecoverguru
real 0m0.053s
user 0m0.049s
sys 0m0.003s

Re: Hi server load

Posted: 2011-02-01T12:32:20-07:00
by magick
Something else must be going on. The command completed in less than 6th one hundreds of a second. Are you sure the server load numbers you are getting are correct? Clearly that particular command put virtually no load on your system

Re: Hi server load

Posted: 2011-02-01T12:35:07-07:00
by ecoverguru
Its 100% correct.. as i said, this is new server moreover its 24 cores + 12 GB RAM .. and I checked the output.. i could see spine.png was created and the image was right as well.