After Upgrade to Mavericks, convert is really slow

Post any defects you find in the released or beta versions of the ImageMagick software here. Include the ImageMagick version, OS, and any command-line required to reproduce the problem. Got a patch for a bug? Post it here.
Post Reply
MarkHunnibell
Posts: 5
Joined: 2011-02-26T10:34:03-07:00
Authentication code: 8675308

After Upgrade to Mavericks, convert is really slow

Post by MarkHunnibell »

I upgraded to Mavericks last night in the middle of some work I was doing on image manipulation of a set of several thousand images (no, I didn't do it while actively processing images) and I have noticed that, after the upgrade, the convert commands I had been executing that had taken only a few seconds before now take substantially longer. Since I cannot go back and do any benchmarks, I can only say that the lag is substantial... probably 15 seconds per image versus a few seconds before. Here's an example of the command I am running:

Code: Select all

convert "Image_0001.png" -crop 3187x5313+0+0 +repage -depth 8 -deskew 40% -gravity center -depth 8 -extent 4205x5413 "Image_0001.png_LEFT.png"
User avatar
magick
Site Admin
Posts: 11064
Joined: 2003-05-31T11:32:55-07:00

Re: After Upgrade to Mavericks, convert is really slow

Post by magick »

Add -debug cache to your command line and post the results. Also post the output of this command: convert -list configure.
MarkHunnibell
Posts: 5
Joined: 2011-02-26T10:34:03-07:00
Authentication code: 8675308

Re: After Upgrade to Mavericks, convert is really slow

Post by MarkHunnibell »

convert -debug cache "Image_0001.png" -crop 5346x3474+0+0 +repage -depth 8 -colorspace Gray -deskew 40% -gravity center -depth 8 -extent 5742x4459 "Image_0001.png_LEFT.png"

Code: Select all

2013-11-08T11:09:47-05:00 0:00.010 0.000u 6.8.7 Cache convert[624]: cache.c/DestroyPixelCache/956/Cache
  destroy 
2013-11-08T11:09:47-05:00 0:00.020 0.000u 6.8.7 Cache convert[624]: cache.c/OpenPixelCache/3589/Cache
  open Image_0001.png[0] (Heap Memory, 5346x3734 152.3MiB)
2013-11-08T11:09:48-05:00 0:00.610 0.570u 6.8.7 Cache convert[624]: cache.c/OpenPixelCache/3589/Cache
  open Image_0001.png[0] (Heap Memory, 5346x3474 141.7MiB)
2013-11-08T11:09:48-05:00 0:00.740 0.660u 6.8.7 Cache convert[624]: cache.c/DestroyPixelCache/956/Cache
  destroy Image_0001.png[0]
2013-11-08T11:09:48-05:00 0:01.040 0.960u 6.8.7 Cache convert[624]: cache.c/OpenPixelCache/3589/Cache
  open Image_0001.png[0] (Heap Memory, 5346x3474 141.7MiB)
2013-11-08T11:09:48-05:00 0:01.500 1.420u 6.8.7 Cache convert[624]: cache.c/OpenPixelCache/3589/Cache
  open Image_0001.png[0] (Heap Memory, 5348x3476 141.8MiB)
2013-11-08T11:09:54-05:00 0:07.090 7.020u 6.8.7 Cache convert[624]: cache.c/DestroyPixelCache/956/Cache
  destroy Image_0001.png[0]
2013-11-08T11:09:54-05:00 0:07.140 7.070u 6.8.7 Cache convert[624]: cache.c/OpenPixelCache/3589/Cache
  open Image_0001.png[0] (Heap Memory, 5742x4459 195.3MiB)
2013-11-08T11:09:54-05:00 0:07.410 7.290u 6.8.7 Cache convert[624]: cache.c/OpenPixelCache/3589/Cache
  open Image_0001.png[0] (Heap Memory, 5742x4459 195.3MiB)
2013-11-08T11:09:54-05:00 0:07.410 7.290u 6.8.7 Cache convert[624]: cache.c/OpenPixelCache/3589/Cache
  open Image_0001.png[0] (Heap Memory, 5348x3476 141.8MiB)
2013-11-08T11:09:54-05:00 0:07.520 7.400u 6.8.7 Cache convert[624]: cache.c/DestroyPixelCache/956/Cache
  destroy Image_0001.png[0]
2013-11-08T11:09:54-05:00 0:07.530 7.410u 6.8.7 Cache convert[624]: cache.c/DestroyPixelCache/956/Cache
  destroy Image_0001.png[0]
2013-11-08T11:09:55-05:00 0:08.010 7.890u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+0]
2013-11-08T11:09:55-05:00 0:08.010 7.890u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+0]
2013-11-08T11:09:55-05:00 0:08.010 7.900u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+44]
2013-11-08T11:09:55-05:00 0:08.010 7.900u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+44]
2013-11-08T11:09:55-05:00 0:08.010 7.900u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+88]
2013-11-08T11:09:55-05:00 0:08.010 7.900u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+88]
2013-11-08T11:09:55-05:00 0:08.010 7.900u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+132]
2013-11-08T11:09:55-05:00 0:08.010 7.900u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+132]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+176]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+176]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+220]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+220]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+264]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+264]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+308]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+308]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+352]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+352]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+396]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+396]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+440]
2013-11-08T11:09:55-05:00 0:08.020 7.900u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+440]
2013-11-08T11:09:55-05:00 0:08.030 7.900u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+484]
2013-11-08T11:09:55-05:00 0:08.030 7.910u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+484]
2013-11-08T11:09:55-05:00 0:08.030 7.910u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+528]
2013-11-08T11:09:55-05:00 0:08.030 7.910u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+528]
2013-11-08T11:09:55-05:00 0:08.030 7.910u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+572]
2013-11-08T11:09:55-05:00 0:08.030 7.910u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+572]
2013-11-08T11:09:55-05:00 0:08.030 7.910u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+616]
2013-11-08T11:09:55-05:00 0:08.030 7.910u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+616]
2013-11-08T11:09:55-05:00 0:08.030 7.910u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+660]
2013-11-08T11:09:55-05:00 0:08.030 7.910u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+660]
2013-11-08T11:09:55-05:00 0:08.030 7.920u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+704]
2013-11-08T11:09:55-05:00 0:08.030 7.920u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+704]
2013-11-08T11:09:55-05:00 0:08.030 7.920u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+748]
2013-11-08T11:09:55-05:00 0:08.030 7.920u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+748]
2013-11-08T11:09:55-05:00 0:08.030 7.920u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+792]
2013-11-08T11:09:55-05:00 0:08.030 7.920u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+792]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+836]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+836]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+880]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+880]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+924]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+924]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+968]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+968]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1012]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1012]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1056]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1056]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1100]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1100]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1144]
2013-11-08T11:09:55-05:00 0:08.040 7.920u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1144]
2013-11-08T11:09:55-05:00 0:08.050 7.930u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1188]
2013-11-08T11:09:55-05:00 0:08.050 7.930u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1188]
2013-11-08T11:09:55-05:00 0:08.050 7.930u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1232]
2013-11-08T11:09:55-05:00 0:08.050 7.930u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1232]
2013-11-08T11:09:55-05:00 0:08.050 7.930u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1276]
2013-11-08T11:09:55-05:00 0:08.050 7.930u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1276]
2013-11-08T11:09:55-05:00 0:08.050 7.930u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1320]
2013-11-08T11:09:55-05:00 0:08.050 7.930u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1320]
2013-11-08T11:09:55-05:00 0:08.050 7.940u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1364]
2013-11-08T11:09:55-05:00 0:08.050 7.940u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1364]
2013-11-08T11:09:55-05:00 0:08.050 7.940u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1408]
2013-11-08T11:09:55-05:00 0:08.050 7.940u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1408]
2013-11-08T11:09:55-05:00 0:08.050 7.940u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1452]
2013-11-08T11:09:55-05:00 0:08.050 7.940u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1452]
2013-11-08T11:09:55-05:00 0:08.050 7.940u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1496]
2013-11-08T11:09:55-05:00 0:08.050 7.940u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1496]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1540]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1540]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1584]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1584]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1628]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1628]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1672]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1672]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1716]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1716]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1760]
2013-11-08T11:09:55-05:00 0:08.060 7.940u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1760]
2013-11-08T11:09:55-05:00 0:08.070 7.940u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1804]
2013-11-08T11:09:55-05:00 0:08.070 7.950u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1804]
2013-11-08T11:09:55-05:00 0:08.070 7.950u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1848]
2013-11-08T11:09:55-05:00 0:08.070 7.950u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1848]
2013-11-08T11:09:55-05:00 0:08.070 7.950u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1892]
2013-11-08T11:09:55-05:00 0:08.070 7.950u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1892]
2013-11-08T11:09:55-05:00 0:08.070 7.950u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1936]
2013-11-08T11:09:55-05:00 0:08.070 7.950u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1936]
2013-11-08T11:09:55-05:00 0:08.070 7.960u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+1980]
2013-11-08T11:09:55-05:00 0:08.070 7.960u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+1980]
2013-11-08T11:09:55-05:00 0:08.070 7.960u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2024]
2013-11-08T11:09:55-05:00 0:08.070 7.960u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2024]
2013-11-08T11:09:55-05:00 0:08.070 7.960u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2068]
2013-11-08T11:09:55-05:00 0:08.070 7.960u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2068]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2112]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2112]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2156]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2156]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2200]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2200]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2244]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2244]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2288]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2288]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2332]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2332]
2013-11-08T11:09:55-05:00 0:08.080 7.960u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2376]
2013-11-08T11:09:55-05:00 0:08.090 7.960u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2376]
2013-11-08T11:09:55-05:00 0:08.090 7.970u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2420]
2013-11-08T11:09:55-05:00 0:08.090 7.970u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2420]
2013-11-08T11:09:55-05:00 0:08.090 7.970u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2464]
2013-11-08T11:09:55-05:00 0:08.090 7.970u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2464]
2013-11-08T11:09:55-05:00 0:08.090 7.970u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2508]
2013-11-08T11:09:55-05:00 0:08.090 7.970u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2508]
2013-11-08T11:09:55-05:00 0:08.090 7.970u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2552]
2013-11-08T11:09:55-05:00 0:08.090 7.970u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2552]
2013-11-08T11:09:55-05:00 0:08.090 7.980u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2596]
2013-11-08T11:09:55-05:00 0:08.090 7.980u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2596]
2013-11-08T11:09:55-05:00 0:08.090 7.980u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2640]
2013-11-08T11:09:55-05:00 0:08.090 7.980u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2640]
2013-11-08T11:09:55-05:00 0:08.090 7.980u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2684]
2013-11-08T11:09:55-05:00 0:08.090 7.980u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2684]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2728]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2728]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2772]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2772]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2816]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2816]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2860]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2860]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2904]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2904]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2948]
2013-11-08T11:09:55-05:00 0:08.100 7.980u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2948]
2013-11-08T11:09:55-05:00 0:08.110 7.980u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+2992]
2013-11-08T11:09:55-05:00 0:08.110 7.980u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+2992]
2013-11-08T11:09:55-05:00 0:08.110 7.990u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3036]
2013-11-08T11:09:55-05:00 0:08.110 7.990u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3036]
2013-11-08T11:09:55-05:00 0:08.110 7.990u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3080]
2013-11-08T11:09:55-05:00 0:08.110 7.990u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3080]
2013-11-08T11:09:55-05:00 0:08.110 8.000u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3124]
2013-11-08T11:09:55-05:00 0:08.110 8.000u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3124]
2013-11-08T11:09:55-05:00 0:08.110 8.000u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3168]
2013-11-08T11:09:55-05:00 0:08.110 8.000u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3168]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3212]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3212]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3256]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3256]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3300]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3300]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3344]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3344]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3388]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3388]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3432]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3432]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3476]
2013-11-08T11:09:55-05:00 0:08.120 8.000u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3476]
2013-11-08T11:09:55-05:00 0:08.130 8.000u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3520]
2013-11-08T11:09:55-05:00 0:08.130 8.000u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3520]
2013-11-08T11:09:55-05:00 0:08.130 8.000u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3564]
2013-11-08T11:09:55-05:00 0:08.130 8.000u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3564]
2013-11-08T11:09:55-05:00 0:08.130 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3608]
2013-11-08T11:09:55-05:00 0:08.130 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3608]
2013-11-08T11:09:55-05:00 0:08.130 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3652]
2013-11-08T11:09:55-05:00 0:08.130 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3652]
2013-11-08T11:09:55-05:00 0:08.130 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3696]
2013-11-08T11:09:55-05:00 0:08.130 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3696]
2013-11-08T11:09:55-05:00 0:08.130 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3740]
2013-11-08T11:09:55-05:00 0:08.130 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3740]
2013-11-08T11:09:55-05:00 0:08.130 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3784]
2013-11-08T11:09:55-05:00 0:08.130 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3784]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3828]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3828]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3872]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3872]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3916]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3916]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+3960]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+3960]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4004]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4004]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4048]
2013-11-08T11:09:55-05:00 0:08.140 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4048]
2013-11-08T11:09:55-05:00 0:08.150 8.020u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4092]
2013-11-08T11:09:55-05:00 0:08.150 8.020u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4092]
2013-11-08T11:09:55-05:00 0:08.150 8.040u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4136]
2013-11-08T11:09:55-05:00 0:08.150 8.040u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4136]
2013-11-08T11:09:55-05:00 0:08.150 8.040u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4180]
2013-11-08T11:09:55-05:00 0:08.150 8.040u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4180]
2013-11-08T11:09:55-05:00 0:08.150 8.040u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4224]
2013-11-08T11:09:55-05:00 0:08.150 8.040u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4224]
2013-11-08T11:09:55-05:00 0:08.150 8.040u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4268]
2013-11-08T11:09:55-05:00 0:08.150 8.040u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4268]
2013-11-08T11:09:55-05:00 0:08.150 8.040u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4312]
2013-11-08T11:09:55-05:00 0:08.150 8.040u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4312]
2013-11-08T11:09:55-05:00 0:08.160 8.040u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4356]
2013-11-08T11:09:55-05:00 0:08.160 8.040u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4356]
2013-11-08T11:09:55-05:00 0:08.160 8.040u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4400]
2013-11-08T11:09:55-05:00 0:08.160 8.040u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4400]
2013-11-08T11:09:55-05:00 0:08.160 8.040u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4444]
2013-11-08T11:09:55-05:00 0:08.160 8.040u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4444]
2013-11-08T11:09:55-05:00 0:08.160 8.040u 6.8.7 Cache convert[624]: cache.c/ReadPixelCachePixels/4485/Cache
  Image_0001.png[0][5742x1+0+4458]
2013-11-08T11:09:55-05:00 0:08.160 8.040u 6.8.7 Cache convert[624]: cache.c/WritePixelCachePixels/5454/Cache
  Image_0001.png_LEFT.png[0][5742x1+0+4458]
2013-11-08T11:09:55-05:00 0:08.160 8.040u 6.8.7 Cache convert[624]: cache.c/ClonePixelCacheRepository/763/Cache
  Memory => Memory
2013-11-08T11:09:55-05:00 0:08.180 8.060u 6.8.7 Cache convert[624]: cache.c/OpenPixelCache/3589/Cache
  open Image_0001.png_LEFT.png[0] (Heap Memory, 5742x4459 244.2MiB)
2013-11-08T11:09:56-05:00 0:09.140 9.020u 6.8.7 Cache convert[624]: cache.c/DestroyPixelCache/956/Cache
  destroy Image_0001.png_LEFT.png[0]



convert -list configure

Code: Select all

Path: /opt/local/lib/ImageMagick-6.8.7//config-Q16/configure.xml

Name           Value
-------------------------------------------------------------------------------
CC             /usr/bin/clang
CFLAGS         -I/opt/local/include/freetype2 -I/opt/local/include -Os -arch x86_64 -Wall -march=core2 -fexceptions -D_FORTIFY_SOURCE=0 -D_THREAD_SAFE -pthread -DMAGICKCORE_HDRI_ENABLE=0 -DMAGICKCORE_QUANTUM_DEPTH=16
CODER_PATH     /opt/local/lib/ImageMagick-6.8.7/modules-Q16/coders
CONFIGURE      ./configure  '--prefix=/opt/local' '--enable-shared' '--enable-static' '--disable-ltdl-install' '--disable-silent-rules' '--with-frozenpaths' '--without-openexr' '--disable-hdri' '--with-dps' '--with-bzlib' '--with-djvu' '--with-fontconfig' '--with-gslib' '--with-jpeg' '--with-lcms' '--with-png' '--with-tiff' '--with-webp' '--with-zlib' '--with-modules' '--with-xml' '--without-perl' '--without-fpx' '--without-jbig' '--without-jp2' '--without-wmf' '--without-gvc' '--without-rsvg' '--without-lqr' '--without-pango' '--with-gs-font-dir=/opt/local/share/fonts/urw-fonts' '--with-x' 'CC=/usr/bin/clang' 'CFLAGS=-Os -arch x86_64' 'LDFLAGS=-L/opt/local/lib -Wl,-headerpad_max_install_names -arch x86_64' 'CPPFLAGS=-I/opt/local/include' 'CXX=/usr/bin/clang++' 'CXXFLAGS=-Os -arch x86_64'
CONFIGURE_PATH /opt/local/etc/ImageMagick-6/
COPYRIGHT      Copyright (C) 1999-2013 ImageMagick Studio LLC
CPPFLAGS       -I/opt/local/include/ImageMagick-6
CXX            /usr/bin/clang++
CXXFLAGS       -Os -arch x86_64 -D_THREAD_SAFE -pthread
DEFS           -DHAVE_CONFIG_H
DELEGATES      bzlib djvu mpeg fftw fontconfig freetype gslib jng jpeg lcms lzma png ps tiff webp x xml zlib
DISTCHECK_CONFIG_FLAGS 'CC=/usr/bin/clang' 'CFLAGS=-Os -arch x86_64' 'CPPFLAGS=-I/opt/local/include' 'CXX=/usr/bin/clang++' 'LDFLAGS=-L/opt/local/lib -Wl,-headerpad_max_install_names -arch x86_64' --disable-deprecated --with-quantum-depth=16 --with-umem=no --with-autotrace=no --with-fpx=no --with-fontpath= --with-gs-font-dir=/opt/local/share/fonts/urw-fonts --with-gvc=no --with-jp2=no --with-lqr=no --with-mupdf=no --with-openexr=no --with-pango=no --with-rsvg=no --with-wmf=no --with-perl=no
DOCUMENTATION_PATH /opt/local/share/doc/ImageMagick-6
EXEC-PREFIX    /opt/local
EXECUTABLE_PATH /opt/local/bin
FEATURES       DPC Modules
FILTER_PATH    /opt/local/lib/ImageMagick-6.8.7/modules-Q16/filters
HOST           x86_64-apple-darwin13.0.0
INCLUDE_PATH   /opt/local/include/ImageMagick-6
LDFLAGS        -L/opt/local/lib -L/opt/local/lib -Wl,-headerpad_max_install_names -arch x86_64 -L/opt/local/lib
LIB_VERSION    0x687
LIB_VERSION_NUMBER 6,8,7,3
LIBRARY_PATH   /opt/local/lib/ImageMagick-6.8.7
LIBS           -llcms2 -L/opt/local/lib -lfreetype -lfftw3 -L/opt/local/lib -lfontconfig -lfreetype -lXext -lSM -lICE -lX11 -lXt -L/opt/local/lib -llzma -lbz2 -lz -lltdl -lm
NAME           ImageMagick
PCFLAGS        -DMAGICKCORE_HDRI_ENABLE=0 -DMAGICKCORE_QUANTUM_DEPTH=16
PREFIX         /opt/local
QuantumDepth   16
RELEASE_DATE   2013-11-08
SHARE_PATH     /opt/local/share/ImageMagick-6
SHAREARCH_PATH /opt/local/lib/ImageMagick-6.8.7/config-Q16
SVN_REVISION   13557
TARGET_CPU     x86_64
TARGET_OS      darwin13.0.0
TARGET_VENDOR  apple
VERSION        6.8.7
WEBSITE        http://www.imagemagick.org

Path: /Users/markhunnibell/.magick/configure.xml

Name           Value
-------------------------------------------------------------------------------
CC             gcc -std=gnu99
CFLAGS         -g -O2 -Wall -W -D_THREAD_SAFE
CONFIGURE      ./configure 
COPYRIGHT      Copyright (C) 1999-2009 ImageMagick Studio LLC
CPPFLAGS       -I/usr/local/include/ImageMagick
CXX            g++
CXXFLAGS       -g -O2 -Wall -W -D_THREAD_SAFE
DEFS           -DHAVE_CONFIG_H
DELEGATES      bzlib fontconfig freetype jbig jpeg lcms 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=
EXEC-PREFIX    /usr/local
HOST           i386-apple-darwin9.6.2
LDFLAGS        -L/usr/local/lib -L/usr/X11/lib -R/usr/X11/lib -L/opt/local/lib -lfreetype -lz -L/opt/local/lib
LIB_VERSION    0x650
LIB_VERSION_NUMBER 6,5,0,0
LIBS           -lMagickCore -llcms -ltiff -lfreetype -ljpeg -L/opt/local/lib -lfontconfig -lexpat -lfreetype -lz -lXext -lSM -lICE -lX11 -lXt -lbz2 -lz -lm -lpthread 
NAME           ImageMagick
PCFLAGS        
PREFIX         /usr/local
QuantumDepth   16
RELEASE_DATE   2009-03-16
VERSION        6.5.0
WEBSITE        http://www.imagemagick.org

Path: [built-in]

Name           Value
-------------------------------------------------------------------------------
FEATURES       
NAME           ImageMagick
QuantumDepth   16
User avatar
magick
Site Admin
Posts: 11064
Joined: 2003-05-31T11:32:55-07:00

Re: After Upgrade to Mavericks, convert is really slow

Post by magick »

OpenMP is not enabled. If you have multiple cores, without OpenMP enabled, ImageMagick will only run on sequentially rather than in parallel. Parallel execution with ImageMagick scales practically linearly with the number of cores on your computer.
MarkHunnibell
Posts: 5
Joined: 2011-02-26T10:34:03-07:00
Authentication code: 8675308

Re: After Upgrade to Mavericks, convert is really slow

Post by MarkHunnibell »

Please pardon me, but the text below has no meaning to me. What are you saying? What is the fix, if any?
magick wrote:OpenMP is not enabled. If you have multiple cores, without OpenMP enabled, ImageMagick will only run on sequentially rather than in parallel. Parallel execution with ImageMagick scales practically linearly with the number of cores on your computer.
User avatar
fmw42
Posts: 25562
Joined: 2007-07-02T17:14:51-07:00
Authentication code: 1152
Location: Sunnyvale, California, USA

Re: After Upgrade to Mavericks, convert is really slow

Post by fmw42 »

I believe he is asking if you are using a computer with multiple cores? If so, check if OpenMP is enable via

convert -version

(It appears from your listing that OpenMP is not enabled.)

If it is not listed and you have multiple cores, then recompile with OpenMP enabled and see if that makes it faster.

Run your command prefaced with the command: time ....

and get the run time so others can test against it.

Also provide your IM version and post your input image (you can post it to some free image hosting service such as dropbox and put a link here to it)
User avatar
fmw42
Posts: 25562
Joined: 2007-07-02T17:14:51-07:00
Authentication code: 1152
Location: Sunnyvale, California, USA

Re: After Upgrade to Mavericks, convert is really slow

Post by fmw42 »

P.S. OpenMP should be enabled by default. To disable it, --disable-openmp would have to be added to the ./configure command.

How did you upgrade? From IM binary, from MacPorts or from source?
MarkHunnibell
Posts: 5
Joined: 2011-02-26T10:34:03-07:00
Authentication code: 8675308

Re: After Upgrade to Mavericks, convert is really slow

Post by MarkHunnibell »

after installing mavericks and updating xcode...

Code: Select all

sudo port upgrade outdated
I changed no configuration.

Before upgrade to Mavericks, it seemed OK... now it seems to take longer.

It's working... just seems to be taking longer.

Beyond that, I don't have time or talent to debug further.
fmw42 wrote:P.S. OpenMP should be enabled by default. To disable it, --disable-openmp would have to be added to the ./configure command.

How did you upgrade? From IM binary, from MacPorts or from source?
User avatar
fmw42
Posts: 25562
Joined: 2007-07-02T17:14:51-07:00
Authentication code: 1152
Location: Sunnyvale, California, USA

Re: After Upgrade to Mavericks, convert is really slow

Post by fmw42 »

If you provide your image or at least the image size, we can provide timings for my Mac Mini Snow Leopard so you can compare. Otherwise, I don't think I can help much further.
Post Reply