How to speed up Image Magick on 2MB images (is *very* slow)
Posted: 2008-09-22T04:22:22-07:00
Hi all,
I'm using convert to create thumbnails for a web application, but the performance is killing us. It's taking 6 seconds on a relatively new linux box, and 15-30 seconds on a decent solaris box to create a single thumbnail from a 2MB image. The command I'm using is:
convert -size 1280x960 'img.jpg[0]' -auto-orient -thumbnail 640x480 -background transparent -gravity center -extent 640x480 ./img-640x480.jpg
Here's the output of identify -list resource:
identify -list resource
File Area Memory Map Disk
------------------------------------------------
192 4gb 3gb 8gb 16eb
Does this look ok?
I've played with the various XXX_LIMIT settings but nothing seems to help. I've run the above convert with "-debug all". Can anyone see anything obviously wrong here? I've pasted the debug output below.
What is embarresing here is that in Java using JAI we can create thumbnails for images like this in about a second on the same hardware.
The biggest jumps in timing in the debug output seems to be here:
2008-09-22T11:40:21+01:00 0:04 3.660u 6.4.1 Cache convert[4737]: cache.c/unknown/1928/Cache
memory => memory
2008-09-22T11:40:28+01:00 0:11 10.120u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][18x480+0+0]
Any ideas and suggestions would be gratefully received.
thanks
Louis
--
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: utility.c/unknown/809/Configure
Command line: /export/louisd/ifs/installed_libraries/osdir/bin/convert {-debug} {all} {-size} {1280x960} {dsc00492.jpg[0]} {-auto-orient} {-thumbnail} {640x480} {-background} {transparent} {-gravity} {center} {-extent} {640x480} {./dsc00492-640x480.jpg}
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/lib/ImageMagick-6.4.1/config/coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/doc/ImageMagick-6.4.1/coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/home/louisd/.magick/coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: coder.c/unknown/634/Configure
Loading coder map "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/coder.xml" ...
2008-09-22T11:40:18+01:00 0:01 0.030u 6.4.1 Module convert[4737]: module.c/unknown/1077/Module
Searching for module "JPEG" using filename "jpeg.la"
2008-09-22T11:40:18+01:00 0:01 0.030u 6.4.1 Module convert[4737]: module.c/unknown/479/Module
Searching for coder module file "jpeg.la" ...
2008-09-22T11:40:18+01:00 0:01 0.030u 6.4.1 Module convert[4737]: module.c/unknown/1097/Module
Opening module at path "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/lib/
ImageMagick-6.4.1/modules-Q16/coders/jpeg.la"
2008-09-22T11:40:18+01:00 0:01 0.030u 6.4.1 Module convert[4737]: module.c/unknown/1131/Module
Method "RegisterJPEGImage" in module "JPEG" at address fedb5848
2008-09-22T11:40:18+01:00 0:01 0.030u 6.4.1 Module convert[4737]: module.c/unknown/1146/Module
Method "UnregisterJPEGImage" in module "JPEG" at address fedb59ac
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Blob convert[4737]: blob.c/unknown/2356/Blob
read 3 magic header bytes
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c
/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/lib/ImageMagick-6.4.1/config/magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/doc/ImageMagick-6.4.1/magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/home/louisd/.magick/magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: magic.c/unknown/679/Configure
Loading magic map "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/magic.xml" ...
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Blob convert[4737]: blob.c/unknown/2356/Blob
read 3 magic header bytes
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/572/Coder
Profile: exif, 7674 bytes
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/765/Coder
Scale factor: 2
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/819/Coder
Interlace: nonprogressive
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/821/Coder
Data precision: 8
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/823/Coder
Geometry: 2848x2136
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/900/Coder
Quality: 97 (approximate)
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/996/Coder
Colorspace: RGB
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1023/Coder
Sampling Factors: 2x1,1x1,1x1
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Area: 46.4121mb/46.4121mb/4gb
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 46.4121mb/46.4121mb/3gb
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Cache convert[4737]: cache.c/unknown/3525/Cache
open dsc00492.jpg[0] (anonymous memory, 2848x2136 46.4121mb)
2008-09-22T11:40:20+01:00 0:03 2.140u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Area: 58.5938mb/58.5938mb/4gb
2008-09-22T11:40:20+01:00 0:03 2.140u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 58.5938mb/105.006mb/3gb
2008-09-22T11:40:20+01:00 0:03 2.140u 6.4.1 Cache convert[4737]: cache.c/unknown/3525/Cache
open dsc00492.jpg[0] (anonymous memory, 3200x2400 58.5938mb)
2008-09-22T11:40:20+01:00 0:03 2.140u 6.4.1 Cache convert[4737]: cache.c/unknown/1928/Cache
memory => memory
2008-09-22T11:40:21+01:00 0:04 3.650u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Area: 2.34375mb/2.34375mb/4gb
2008-09-22T11:40:21+01:00 0:04 3.650u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 2.34375mb/107.35mb/3gb
2008-09-22T11:40:21+01:00 0:04 3.650u 6.4.1 Cache convert[4737]: cache.c/unknown/3525/Cache
open dsc00492.jpg[0] (anonymous memory, 640x480 2.34375mb)
2008-09-22T11:40:21+01:00 0:04 3.650u 6.4.1 Cache convert[4737]: cache.c/unknown/1928/Cache
memory => memory
2008-09-22T11:40:21+01:00 0:04 3.660u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Area: 11.7188mb/11.7188mb/4gb
2008-09-22T11:40:21+01:00 0:04 3.660u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 11.7188mb/119.068mb/3gb
2008-09-22T11:40:21+01:00 0:04 3.660u 6.4.1 Cache convert[4737]: cache.c/unknown/3525/Cache
open dsc00492.jpg[0] (anonymous memory, 3200x480 11.7188mb)
2008-09-22T11:40:21+01:00 0:04 3.660u 6.4.1 Cache convert[4737]: cache.c/unknown/1928/Cache
memory => memory
2008-09-22T11:40:28+01:00 0:11 10.120u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][18x480+0+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+0+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][23x480+0+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+1+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][28x480+0+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+2+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+2+0]
2008-09-22T11:40:28+01:00 0:11 10.140u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+4+0]
2008-09-22T11:40:28+01:00 0:11 10.150u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+8+0]
2008-09-22T11:40:28+01:00 0:11 10.150u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+32+0]
2008-09-22T11:40:28+01:00 0:11 10.170u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+16+0]
2008-09-22T11:40:28+01:00 0:11 10.210u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+32+0]
2008-09-22T11:40:28+01:00 0:11 10.290u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+64+0]
2008-09-22T11:40:28+01:00 0:11 10.390u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+512+0]
2008-09-22T11:40:28+01:00 0:11 10.440u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+128+0]
2008-09-22T11:40:28+01:00 0:11 10.690u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+1152+0]
2008-09-22T11:40:28+01:00 0:11 10.750u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+256+0]
2008-09-22T11:40:29+01:00 0:12 11.010u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+1792+0]
2008-09-22T11:40:29+01:00 0:12 11.050u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+384+0]
2008-09-22T11:40:29+01:00 0:12 11.310u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+2432+0]
2008-09-22T11:40:29+01:00 0:12 11.360u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+512+0]
2008-09-22T11:40:29+01:00 0:12 11.610u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+3072+0]
2008-09-22T11:40:29+01:00 0:12 11.670u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+639+0]
2008-09-22T11:40:29+01:00 0:12 11.680u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 11.7188mb/107.35mb/3gb
2008-09-22T11:40:29+01:00 0:12 11.680u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy dsc00492.jpg[0]
2008-09-22T11:40:29+01:00 0:12 11.740u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 58.5938mb/48.7559mb/3gb
2008-09-22T11:40:29+01:00 0:12 11.740u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy dsc00492.jpg[0]
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 46.4121mb/2.34375mb/3gb
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy dsc00492.jpg[0]
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/lib/ImageMagick-6.4.1/config/colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/doc/ImageMagick-6.4.1/colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/home/louisd/.magick/colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.890u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.890u 6.4.1 Configure convert[4737]: color.c/unknown/2692/Configure
Loading color map "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/colors.xml" ...
2008-09-22T11:40:30+01:00 0:13 12.100u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Area: 2.34375mb/2.34375mb/4gb
2008-09-22T11:40:30+01:00 0:13 12.100u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 2.34375mb/4.6875mb/3gb
2008-09-22T11:40:30+01:00 0:13 12.100u 6.4.1 Cache convert[4737]: cache.c/unknown/3525/Cache
open dsc00492.jpg[0] (anonymous memory, 640x480 2.34375mb)
2008-09-22T11:40:30+01:00 0:13 12.100u 6.4.1 Cache convert[4737]: cache.c/unknown/1928/Cache
memory => memory
2008-09-22T11:40:30+01:00 0:13 12.590u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 2.34375mb/2.34375mb/3gb
2008-09-22T11:40:30+01:00 0:13 12.590u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy dsc00492.jpg[0]
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1661/Coder
Image resolution: 72,72
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 2.34375mb/4.6875mb/3gb
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 2.34375mb/2.34375mb/3gb
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1707/Coder
Interlace: non-progressive
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1722/Coder
Quality: 97
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1762/Coder
Input sampling-factors=2x1,1x1,1x1
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1826/Coder
Storage class: DirectClass
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1828/Coder
Depth: 16
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1834/Coder
Number of colors: unspecified
2008-09-22T11:40:30+01:00 0:13 12.620u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1836/Coder
JPEG data precision: 8
2008-09-22T11:40:30+01:00 0:13 12.620u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1890/Coder
Image colorspace is RGB
2008-09-22T11:40:30+01:00 0:13 12.620u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1892/Coder
Sampling factors: 2x1,1x1,1x1
2008-09-22T11:40:30+01:00 0:13 12.850u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 2.34375mb/0b/3gb
2008-09-22T11:40:30+01:00 0:13 12.850u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy dsc00492.jpg[0]
I'm using convert to create thumbnails for a web application, but the performance is killing us. It's taking 6 seconds on a relatively new linux box, and 15-30 seconds on a decent solaris box to create a single thumbnail from a 2MB image. The command I'm using is:
convert -size 1280x960 'img.jpg[0]' -auto-orient -thumbnail 640x480 -background transparent -gravity center -extent 640x480 ./img-640x480.jpg
Here's the output of identify -list resource:
identify -list resource
File Area Memory Map Disk
------------------------------------------------
192 4gb 3gb 8gb 16eb
Does this look ok?
I've played with the various XXX_LIMIT settings but nothing seems to help. I've run the above convert with "-debug all". Can anyone see anything obviously wrong here? I've pasted the debug output below.
What is embarresing here is that in Java using JAI we can create thumbnails for images like this in about a second on the same hardware.
The biggest jumps in timing in the debug output seems to be here:
2008-09-22T11:40:21+01:00 0:04 3.660u 6.4.1 Cache convert[4737]: cache.c/unknown/1928/Cache
memory => memory
2008-09-22T11:40:28+01:00 0:11 10.120u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][18x480+0+0]
Any ideas and suggestions would be gratefully received.
thanks
Louis
--
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: utility.c/unknown/809/Configure
Command line: /export/louisd/ifs/installed_libraries/osdir/bin/convert {-debug} {all} {-size} {1280x960} {dsc00492.jpg[0]} {-auto-orient} {-thumbnail} {640x480} {-background} {transparent} {-gravity} {center} {-extent} {640x480} {./dsc00492-640x480.jpg}
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/lib/ImageMagick-6.4.1/config/coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/doc/ImageMagick-6.4.1/coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/home/louisd/.magick/coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "coder.xml"
2008-09-22T11:40:18+01:00 0:01 0.010u 6.4.1 Configure convert[4737]: coder.c/unknown/634/Configure
Loading coder map "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/coder.xml" ...
2008-09-22T11:40:18+01:00 0:01 0.030u 6.4.1 Module convert[4737]: module.c/unknown/1077/Module
Searching for module "JPEG" using filename "jpeg.la"
2008-09-22T11:40:18+01:00 0:01 0.030u 6.4.1 Module convert[4737]: module.c/unknown/479/Module
Searching for coder module file "jpeg.la" ...
2008-09-22T11:40:18+01:00 0:01 0.030u 6.4.1 Module convert[4737]: module.c/unknown/1097/Module
Opening module at path "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/lib/
ImageMagick-6.4.1/modules-Q16/coders/jpeg.la"
2008-09-22T11:40:18+01:00 0:01 0.030u 6.4.1 Module convert[4737]: module.c/unknown/1131/Module
Method "RegisterJPEGImage" in module "JPEG" at address fedb5848
2008-09-22T11:40:18+01:00 0:01 0.030u 6.4.1 Module convert[4737]: module.c/unknown/1146/Module
Method "UnregisterJPEGImage" in module "JPEG" at address fedb59ac
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Blob convert[4737]: blob.c/unknown/2356/Blob
read 3 magic header bytes
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c
/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/lib/ImageMagick-6.4.1/config/magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/doc/ImageMagick-6.4.1/magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/home/louisd/.magick/magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "magic.xml"
2008-09-22T11:40:18+01:00 0:01 0.040u 6.4.1 Configure convert[4737]: magic.c/unknown/679/Configure
Loading magic map "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/magic.xml" ...
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Blob convert[4737]: blob.c/unknown/2356/Blob
read 3 magic header bytes
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/572/Coder
Profile: exif, 7674 bytes
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/765/Coder
Scale factor: 2
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/819/Coder
Interlace: nonprogressive
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/821/Coder
Data precision: 8
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/823/Coder
Geometry: 2848x2136
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/900/Coder
Quality: 97 (approximate)
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/996/Coder
Colorspace: RGB
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1023/Coder
Sampling Factors: 2x1,1x1,1x1
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Area: 46.4121mb/46.4121mb/4gb
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 46.4121mb/46.4121mb/3gb
2008-09-22T11:40:18+01:00 0:01 0.070u 6.4.1 Cache convert[4737]: cache.c/unknown/3525/Cache
open dsc00492.jpg[0] (anonymous memory, 2848x2136 46.4121mb)
2008-09-22T11:40:20+01:00 0:03 2.140u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Area: 58.5938mb/58.5938mb/4gb
2008-09-22T11:40:20+01:00 0:03 2.140u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 58.5938mb/105.006mb/3gb
2008-09-22T11:40:20+01:00 0:03 2.140u 6.4.1 Cache convert[4737]: cache.c/unknown/3525/Cache
open dsc00492.jpg[0] (anonymous memory, 3200x2400 58.5938mb)
2008-09-22T11:40:20+01:00 0:03 2.140u 6.4.1 Cache convert[4737]: cache.c/unknown/1928/Cache
memory => memory
2008-09-22T11:40:21+01:00 0:04 3.650u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Area: 2.34375mb/2.34375mb/4gb
2008-09-22T11:40:21+01:00 0:04 3.650u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 2.34375mb/107.35mb/3gb
2008-09-22T11:40:21+01:00 0:04 3.650u 6.4.1 Cache convert[4737]: cache.c/unknown/3525/Cache
open dsc00492.jpg[0] (anonymous memory, 640x480 2.34375mb)
2008-09-22T11:40:21+01:00 0:04 3.650u 6.4.1 Cache convert[4737]: cache.c/unknown/1928/Cache
memory => memory
2008-09-22T11:40:21+01:00 0:04 3.660u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Area: 11.7188mb/11.7188mb/4gb
2008-09-22T11:40:21+01:00 0:04 3.660u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 11.7188mb/119.068mb/3gb
2008-09-22T11:40:21+01:00 0:04 3.660u 6.4.1 Cache convert[4737]: cache.c/unknown/3525/Cache
open dsc00492.jpg[0] (anonymous memory, 3200x480 11.7188mb)
2008-09-22T11:40:21+01:00 0:04 3.660u 6.4.1 Cache convert[4737]: cache.c/unknown/1928/Cache
memory => memory
2008-09-22T11:40:28+01:00 0:11 10.120u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][18x480+0+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+0+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][23x480+0+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+1+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][28x480+0+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+2+0]
2008-09-22T11:40:28+01:00 0:11 10.130u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+2+0]
2008-09-22T11:40:28+01:00 0:11 10.140u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+4+0]
2008-09-22T11:40:28+01:00 0:11 10.150u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+8+0]
2008-09-22T11:40:28+01:00 0:11 10.150u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+32+0]
2008-09-22T11:40:28+01:00 0:11 10.170u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+16+0]
2008-09-22T11:40:28+01:00 0:11 10.210u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+32+0]
2008-09-22T11:40:28+01:00 0:11 10.290u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+64+0]
2008-09-22T11:40:28+01:00 0:11 10.390u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+512+0]
2008-09-22T11:40:28+01:00 0:11 10.440u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+128+0]
2008-09-22T11:40:28+01:00 0:11 10.690u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+1152+0]
2008-09-22T11:40:28+01:00 0:11 10.750u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+256+0]
2008-09-22T11:40:29+01:00 0:12 11.010u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+1792+0]
2008-09-22T11:40:29+01:00 0:12 11.050u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+384+0]
2008-09-22T11:40:29+01:00 0:12 11.310u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+2432+0]
2008-09-22T11:40:29+01:00 0:12 11.360u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+512+0]
2008-09-22T11:40:29+01:00 0:12 11.610u 6.4.1 Cache convert[4737]: cache.c/unknown/3970/Cache
dsc00492.jpg[0][31x480+3072+0]
2008-09-22T11:40:29+01:00 0:12 11.670u 6.4.1 Cache convert[4737]: cache.c/unknown/4885/Cache
dsc00492.jpg[0][1x480+639+0]
2008-09-22T11:40:29+01:00 0:12 11.680u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 11.7188mb/107.35mb/3gb
2008-09-22T11:40:29+01:00 0:12 11.680u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy dsc00492.jpg[0]
2008-09-22T11:40:29+01:00 0:12 11.740u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 58.5938mb/48.7559mb/3gb
2008-09-22T11:40:29+01:00 0:12 11.740u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy dsc00492.jpg[0]
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 46.4121mb/2.34375mb/3gb
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy dsc00492.jpg[0]
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/lib/ImageMagick-6.4.1/config/colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/doc/ImageMagick-6.4.1/colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.880u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "/home/louisd/.magick/colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.890u 6.4.1 Configure convert[4737]: configure.c/unknown/482/Configure
Searching for configure file: "colors.xml"
2008-09-22T11:40:29+01:00 0:12 11.890u 6.4.1 Configure convert[4737]: color.c/unknown/2692/Configure
Loading color map "/tmp/louisd/ifs.7.3.145/installed_libraries/osdir/share/ImageMagick-6.4.1/config/colors.xml" ...
2008-09-22T11:40:30+01:00 0:13 12.100u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Area: 2.34375mb/2.34375mb/4gb
2008-09-22T11:40:30+01:00 0:13 12.100u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 2.34375mb/4.6875mb/3gb
2008-09-22T11:40:30+01:00 0:13 12.100u 6.4.1 Cache convert[4737]: cache.c/unknown/3525/Cache
open dsc00492.jpg[0] (anonymous memory, 640x480 2.34375mb)
2008-09-22T11:40:30+01:00 0:13 12.100u 6.4.1 Cache convert[4737]: cache.c/unknown/1928/Cache
memory => memory
2008-09-22T11:40:30+01:00 0:13 12.590u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 2.34375mb/2.34375mb/3gb
2008-09-22T11:40:30+01:00 0:13 12.590u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy dsc00492.jpg[0]
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1661/Coder
Image resolution: 72,72
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Resource convert[4737]: resource.c/unknown/219/Resource
Memory: 2.34375mb/4.6875mb/3gb
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 2.34375mb/2.34375mb/3gb
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1707/Coder
Interlace: non-progressive
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1722/Coder
Quality: 97
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1762/Coder
Input sampling-factors=2x1,1x1,1x1
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1826/Coder
Storage class: DirectClass
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1828/Coder
Depth: 16
2008-09-22T11:40:30+01:00 0:13 12.610u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1834/Coder
Number of colors: unspecified
2008-09-22T11:40:30+01:00 0:13 12.620u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1836/Coder
JPEG data precision: 8
2008-09-22T11:40:30+01:00 0:13 12.620u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1890/Coder
Image colorspace is RGB
2008-09-22T11:40:30+01:00 0:13 12.620u 6.4.1 Coder convert[4737]: jpeg.c/unknown/1892/Coder
Sampling factors: 2x1,1x1,1x1
2008-09-22T11:40:30+01:00 0:13 12.850u 6.4.1 Resource convert[4737]: resource.c/unknown/834/Resource
Memory: 2.34375mb/0b/3gb
2008-09-22T11:40:30+01:00 0:13 12.850u 6.4.1 Cache convert[4737]: cache.c/unknown/2162/Cache
destroy dsc00492.jpg[0]