Legacy ImageMagick Discussions Archive

Use https://github.com/ImageMagick/ImageMagick/discussions instead.
https://imagemagick.com/discourse-server/

Can someone help to analyse the debug trace ?

https://imagemagick.com/discourse-server/viewtopic.php?t=17730

Page 1 of 1

Can someone help to analyse the debug trace ?

Posted: 2010-12-22T08:48:22-07:00
by skywalker826
Hi,

I have two PDFs, one can be generated with preview image (PNG), another one is just generated with blank.

I enable the debug option in my convert command.

convert SOME_DIR/<source pdf file> -debug all -colorspace RGB -geometry 400 -quality 80 SOME_DIR/<preview file>.png

The pdf that is OK

Code: Select all

10:33:36 0:01 0.010u 6.0.7 convert[3549]: blob.c/OpenBlob/1812/Blob
    read 1 magic header bytes
10:33:36 0:01 0.010u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  area: 0/0/504.0mb
10:33:36 0:01 0.010u 6.0.7 convert[3549]: cache.c/DestroyCacheInfo/1193/Cache
  destroy 
10:33:36 0:01 0.010u 6.0.7 convert[3549]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/lib/ImageMagick-6.0.7/config/magic.mgk"
10:33:36 0:01 0.010u 6.0.7 convert[3549]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/share/ImageMagick-6.0.7/config/magic.mgk"
10:33:36 0:01 0.010u 6.0.7 convert[3549]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/share/ImageMagick-6.0.7/magic.mgk"
10:33:36 0:01 0.010u 6.0.7 convert[3549]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "magic.mgk"
10:33:36 0:01 0.010u 6.0.7 convert[3549]: magic.c/LoadMagicList/683/Configure
  Loading magic file "/usr/lib/ImageMagick-6.0.7/config/magic.mgk" ...
10:33:36 0:01 0.010u 6.0.7 convert[3549]: blob.c/OpenBlob/1812/Blob
    read 1 magic header bytes
10:33:36 0:01 0.010u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  area: 0/0/504.0mb
10:33:36 0:01 0.010u 6.0.7 convert[3549]: cache.c/DestroyCacheInfo/1193/Cache
  destroy 
10:33:36 0:01 0.010u 6.0.7 convert[3549]: blob.c/OpenBlob/1812/Blob
    read 1 magic header bytes
10:33:36 0:01 0.010u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  area: 0/0/504.0mb
10:33:36 0:01 0.010u 6.0.7 convert[3549]: cache.c/DestroyCacheInfo/1193/Cache
  destroy 
10:33:36 0:01 0.010u 6.0.7 convert[3549]: resource.c/AcquireUniqueFileResource/369/Resource
  /tmp/magick-XX72aMcN
10:33:36 0:01 0.010u 6.0.7 convert[3549]: resource.c/AcquireMagickResource/209/Resource
  file: 1/1/12kb
10:33:36 0:01 0.010u 6.0.7 convert[3549]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/lib/ImageMagick-6.0.7/config/delegates.mgk"
10:33:36 0:01 0.010u 6.0.7 convert[3549]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/share/ImageMagick-6.0.7/config/delegates.mgk"
10:33:36 0:01 0.010u 6.0.7 convert[3549]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/share/ImageMagick-6.0.7/delegates.mgk"
10:33:36 0:01 0.010u 6.0.7 convert[3549]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "delegates.mgk"
10:33:36 0:01 0.010u 6.0.7 convert[3549]: delegate.c/LoadDelegateList/1110/Configure
  Loading delegate file "/usr/lib/ImageMagick-6.0.7/config/delegates.mgk" ...
10:33:36 0:01 0.020u 6.0.7 convert[3549]: resource.c/AcquireUniqueFileResource/369/Resource
  /tmp/magick-XXpJkSmj
10:33:36 0:01 0.020u 6.0.7 convert[3549]: resource.c/AcquireMagickResource/209/Resource
  file: 1/2/12kb
10:33:36 0:01 0.020u 6.0.7 convert[3549]: blob.c/OpenBlob/1812/Blob
    read 1 magic header bytes
10:33:36 0:01 0.020u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  area: 0/0/504.0mb
10:33:36 0:01 0.020u 6.0.7 convert[3549]: cache.c/DestroyCacheInfo/1193/Cache
  destroy 
10:33:36 0:01 0.020u 6.0.7 convert[3549]: blob.c/OpenBlob/1812/Blob
    read 1 magic header bytes
10:33:36 0:01 0.020u 6.0.7 convert[3549]: resource.c/AcquireMagickResource/209/Resource
  area: 3.8mb/3.8mb/504.0mb
10:33:36 0:01 0.020u 6.0.7 convert[3549]: resource.c/AcquireMagickResource/209/Resource
  memory: 3.8mb/3.8mb/1008.0mb
10:33:36 0:01 0.020u 6.0.7 convert[3549]: cache.c/OpenCache/2372/Cache
  open /tmp/magick-XXpJkSmj[0] (memory, 3.8mb)
10:33:36 0:01 0.030u 6.0.7 convert[3549]: resource.c/RelinquishUniqueFileResource/743/Resource
  /tmp/magick-XX72aMcN
10:33:36 0:01 0.030u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  file: 1/1/12kb
10:33:36 0:01 0.030u 6.0.7 convert[3549]: resource.c/RelinquishUniqueFileResource/743/Resource
  /tmp/magick-XXpJkSmj
10:33:36 0:01 0.030u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  file: 1/0/12kb
10:33:36 0:01 0.040u 6.0.7 convert[3549]: resource.c/AcquireMagickResource/209/Resource
  area: 2.6mb/6.4mb/504.0mb
10:33:36 0:01 0.040u 6.0.7 convert[3549]: resource.c/AcquireMagickResource/209/Resource
  memory: 2.6mb/6.4mb/1008.0mb
10:33:36 0:01 0.040u 6.0.7 convert[3549]: cache.c/OpenCache/2372/Cache
  open assets/files/test5_Compression_JPEG_Lossy_TEST.pdf[0] (memory, 2.6mb)
10:33:36 0:01 0.150u 6.0.7 convert[3549]: resource.c/AcquireMagickResource/209/Resource
  area: 1.7mb/8.1mb/504.0mb
10:33:36 0:01 0.150u 6.0.7 convert[3549]: resource.c/AcquireMagickResource/209/Resource
  memory: 1.7mb/8.1mb/1008.0mb
10:33:36 0:01 0.150u 6.0.7 convert[3549]: cache.c/OpenCache/2372/Cache
  open assets/files/test5_Compression_JPEG_Lossy_TEST.pdf[0] (memory, 1.7mb)
10:33:36 0:01 0.200u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  memory: 2.6mb/5.5mb/1008.0mb
10:33:36 0:01 0.200u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  area: 2.6mb/5.5mb/504.0mb
10:33:36 0:01 0.200u 6.0.7 convert[3549]: cache.c/DestroyCacheInfo/1193/Cache
  destroy assets/files/test5_Compression_JPEG_Lossy_TEST.pdf[0]
10:33:36 0:01 0.200u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  memory: 3.8mb/1.7mb/1008.0mb
10:33:36 0:01 0.200u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  area: 3.8mb/1.7mb/504.0mb
10:33:36 0:01 0.200u 6.0.7 convert[3549]: cache.c/DestroyCacheInfo/1193/Cache
  destroy /tmp/magick-XXpJkSmj[0]
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WritePNGImage/7196/Coder
  enter WritePNGImage()
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/5992/Coder
    enter WriteOnePNGImage()
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6057/Coder
      width=400
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6059/Coder
      height=566
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6061/Coder
      image->depth=8
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6101/Coder
      Setting up pHYs chunk
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6324/Coder
      Tentative PNG color type: 2
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6326/Coder
      image_info->type: 0
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6328/Coder
      image->depth: 8
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6330/Coder
      ping_info->bit_depth: 8
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6675/Coder
      PNG color type: 2
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6681/Coder
    Setting up deflate compression
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6685/Coder
      Compression buffer size: 32768
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6690/Coder
      Compression mem level: 9
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6701/Coder
      Compression level: 8
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6713/Coder
    Setting up filtering
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6727/Coder
      Filter_type: 0
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6752/Coder
      Base filter method: NONE
10:33:36 0:01 0.200u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/6832/Coder
    Writing PNG header chunks
10:33:36 0:01 0.290u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/7012/Coder
    Writing PNG image data
10:33:36 0:01 0.290u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/7014/Coder
      Width: 400
10:33:36 0:01 0.290u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/7016/Coder
      Height: 566
10:33:36 0:01 0.290u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/7018/Coder
      PNG sample depth: 8
10:33:36 0:01 0.290u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/7020/Coder
      PNG color type: 2
10:33:36 0:01 0.290u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/7022/Coder
      PNG Interlace method: 0
10:33:36 0:01 0.290u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/7053/Coder
    Setting up text chunk
10:33:36 0:01 0.290u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/7055/Coder
      keyword: comment
10:33:36 0:01 0.290u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/7091/Coder
    Writing PNG end info
10:33:36 0:01 0.290u 6.0.7 convert[3549]: png.c/WriteOnePNGImage/7167/Coder
    exit WriteOnePNGImage()
10:33:36 0:01 0.290u 6.0.7 convert[3549]: png.c/WritePNGImage/7223/Coder
  exit WritePNGImage()
10:33:36 0:01 0.290u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  memory: 1.7mb/0/1008.0mb
10:33:36 0:01 0.290u 6.0.7 convert[3549]: resource.c/RelinquishMagickResource/710/Resource
  area: 1.7mb/0/504.0mb
10:33:36 0:01 0.290u 6.0.7 convert[3549]: cache.c/DestroyCacheInfo/1193/Cache
  destroy assets/files/test5_Compression_JPEG_Lossy_TEST.pdf[0]

The pdf that is NOT OK, and generated blank preview page

Code: Select all

10:31:41 0:01 0.010u 6.0.7 convert[3538]: blob.c/OpenBlob/1812/Blob
    read 1 magic header bytes
10:31:41 0:01 0.010u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 0/0/504.0mb
10:31:41 0:01 0.010u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy 
10:31:41 0:01 0.010u 6.0.7 convert[3538]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/lib/ImageMagick-6.0.7/config/magic.mgk"
10:31:41 0:01 0.010u 6.0.7 convert[3538]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/share/ImageMagick-6.0.7/config/magic.mgk"
10:31:41 0:01 0.010u 6.0.7 convert[3538]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/share/ImageMagick-6.0.7/magic.mgk"
10:31:41 0:01 0.010u 6.0.7 convert[3538]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "magic.mgk"
10:31:41 0:01 0.010u 6.0.7 convert[3538]: magic.c/LoadMagicList/683/Configure
  Loading magic file "/usr/lib/ImageMagick-6.0.7/config/magic.mgk" ...
10:31:41 0:01 0.010u 6.0.7 convert[3538]: blob.c/OpenBlob/1812/Blob
    read 1 magic header bytes
10:31:41 0:01 0.010u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 0/0/504.0mb
10:31:41 0:01 0.010u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy 
10:31:41 0:01 0.010u 6.0.7 convert[3538]: blob.c/OpenBlob/1812/Blob
    read 1 magic header bytes
10:31:41 0:01 0.020u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 0/0/504.0mb
10:31:41 0:01 0.020u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy 
10:31:41 0:01 0.020u 6.0.7 convert[3538]: resource.c/AcquireUniqueFileResource/369/Resource
  /tmp/magick-XXBgs5qF
10:31:41 0:01 0.020u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  file: 1/1/12kb
10:31:41 0:01 0.020u 6.0.7 convert[3538]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/lib/ImageMagick-6.0.7/config/delegates.mgk"
10:31:41 0:01 0.020u 6.0.7 convert[3538]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/share/ImageMagick-6.0.7/config/delegates.mgk"
10:31:41 0:01 0.020u 6.0.7 convert[3538]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "/usr/share/ImageMagick-6.0.7/delegates.mgk"
10:31:41 0:01 0.020u 6.0.7 convert[3538]: configure.c/GetConfigureOptions/491/Configure
  Searching for configure file: "delegates.mgk"
10:31:41 0:01 0.020u 6.0.7 convert[3538]: delegate.c/LoadDelegateList/1110/Configure
  Loading delegate file "/usr/lib/ImageMagick-6.0.7/config/delegates.mgk" ...
10:31:41 0:01 0.030u 6.0.7 convert[3538]: resource.c/AcquireUniqueFileResource/369/Resource
  /tmp/magick-XXfbM1my
10:31:41 0:01 0.030u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  file: 1/2/12kb
10:31:42 0:01 0.030u 6.0.7 convert[3538]: blob.c/OpenBlob/1812/Blob
    read 1 magic header bytes
10:31:42 0:01 0.030u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 0/0/504.0mb
10:31:42 0:01 0.030u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy 
10:31:42 0:01 0.030u 6.0.7 convert[3538]: blob.c/OpenBlob/1812/Blob
    read 1 magic header bytes
10:31:42 0:01 0.030u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 0/0/504.0mb
10:31:42 0:01 0.030u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy 
10:31:42 0:01 0.030u 6.0.7 convert[3538]: blob.c/OpenBlob/1812/Blob
    read 1 magic header bytes
10:31:42 0:01 0.030u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/573/Coder
    Magick: BM
10:31:42 0:01 0.030u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/583/Coder
    BMP size: 40
10:31:42 0:01 0.030u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/629/Coder
    Format: MS Windows bitmap
10:31:42 0:01 0.030u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/631/Coder
    Geometry: 612x792
10:31:42 0:01 0.030u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/633/Coder
    Bits per pixel: 8
10:31:42 0:01 0.030u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/639/Coder
    Compression: BI_RGB
10:31:42 0:01 0.030u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/679/Coder
    Number of colors: 0
10:31:42 0:01 0.030u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/840/Coder
    Reading colormap of 256 colors
10:31:42 0:01 0.030u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/884/Coder
    Reading pixels (484704 bytes)
10:31:42 0:01 0.030u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  area: 4.6mb/4.6mb/504.0mb
10:31:42 0:01 0.030u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  memory: 4.6mb/4.6mb/1008.0mb
10:31:42 0:01 0.030u 6.0.7 convert[3538]: cache.c/OpenCache/2372/Cache
  open /tmp/magick-XXfbM1my[0] (memory, 4.6mb)
10:31:42 0:01 0.040u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/573/Coder
    Magick: BM
10:31:42 0:01 0.040u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/583/Coder
    BMP size: 40
10:31:42 0:01 0.040u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/629/Coder
    Format: MS Windows bitmap
10:31:42 0:01 0.040u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/631/Coder
    Geometry: 612x792
10:31:42 0:01 0.040u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/633/Coder
    Bits per pixel: 8
10:31:42 0:01 0.040u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/639/Coder
    Compression: BI_RGB
10:31:42 0:01 0.040u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/679/Coder
    Number of colors: 0
10:31:42 0:01 0.040u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/840/Coder
    Reading colormap of 256 colors
10:31:42 0:01 0.040u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/884/Coder
    Reading pixels (484704 bytes)
10:31:42 0:01 0.040u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  area: 4.6mb/9.2mb/504.0mb
10:31:42 0:01 0.040u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  memory: 4.6mb/9.2mb/1008.0mb
10:31:42 0:01 0.040u 6.0.7 convert[3538]: cache.c/OpenCache/2372/Cache
  open /tmp/magick-XXfbM1my[1] (memory, 4.6mb)
10:31:42 0:01 0.060u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/573/Coder
    Magick: BM
10:31:42 0:01 0.060u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/583/Coder
    BMP size: 40
10:31:42 0:01 0.060u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/629/Coder
    Format: MS Windows bitmap
10:31:42 0:01 0.060u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/631/Coder
    Geometry: 612x792
10:31:42 0:01 0.060u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/633/Coder
    Bits per pixel: 8
10:31:42 0:01 0.060u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/639/Coder
    Compression: BI_RGB
10:31:42 0:01 0.060u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/679/Coder
    Number of colors: 0
10:31:42 0:01 0.060u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/840/Coder
    Reading colormap of 256 colors
10:31:42 0:01 0.060u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/884/Coder
    Reading pixels (484704 bytes)
10:31:42 0:01 0.060u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  area: 4.6mb/13.9mb/504.0mb
10:31:42 0:01 0.060u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  memory: 4.6mb/13.9mb/1008.0mb
10:31:42 0:01 0.060u 6.0.7 convert[3538]: cache.c/OpenCache/2372/Cache
  open /tmp/magick-XXfbM1my[2] (memory, 4.6mb)
10:31:42 0:01 0.080u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/573/Coder
    Magick: BM
10:31:42 0:01 0.080u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/583/Coder
    BMP size: 40
10:31:42 0:01 0.080u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/629/Coder
    Format: MS Windows bitmap
10:31:42 0:01 0.080u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/631/Coder
    Geometry: 612x792
10:31:42 0:01 0.080u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/633/Coder
    Bits per pixel: 8
10:31:42 0:01 0.080u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/639/Coder
    Compression: BI_RGB
10:31:42 0:01 0.080u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/679/Coder
    Number of colors: 0
10:31:42 0:01 0.080u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/840/Coder
    Reading colormap of 256 colors
10:31:42 0:01 0.080u 6.0.7 convert[3538]: bmp.c/ReadBMPImage/884/Coder
    Reading pixels (484704 bytes)
10:31:42 0:01 0.080u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  area: 4.6mb/18.5mb/504.0mb
10:31:42 0:01 0.080u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  memory: 4.6mb/18.5mb/1008.0mb
10:31:42 0:01 0.080u 6.0.7 convert[3538]: cache.c/OpenCache/2372/Cache
  open /tmp/magick-XXfbM1my[3] (memory, 4.6mb)
10:31:42 0:01 0.080u 6.0.7 convert[3538]: resource.c/RelinquishUniqueFileResource/743/Resource
  /tmp/magick-XXBgs5qF
10:31:42 0:01 0.080u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  file: 1/1/12kb
10:31:42 0:01 0.090u 6.0.7 convert[3538]: resource.c/RelinquishUniqueFileResource/743/Resource
  /tmp/magick-XXfbM1my
10:31:42 0:01 0.090u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  file: 1/0/12kb
10:31:42 0:01 0.090u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  area: 4.6mb/23.1mb/504.0mb
10:31:42 0:01 0.090u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  memory: 4.6mb/23.1mb/1008.0mb
10:31:42 0:01 0.090u 6.0.7 convert[3538]: cache.c/OpenCache/2372/Cache
  open /tmp/magick-XXfbM1my[0] (memory, 4.6mb)
10:31:42 0:01 0.160u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  memory: 4.6mb/18.5mb/1008.0mb
10:31:42 0:01 0.160u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 4.6mb/18.5mb/504.0mb
10:31:42 0:01 0.160u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy /tmp/magick-XXfbM1my[0]
10:31:42 0:01 0.160u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  memory: 4.6mb/13.9mb/1008.0mb
10:31:42 0:01 0.160u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 4.6mb/13.9mb/504.0mb
10:31:42 0:01 0.160u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy /tmp/magick-XXfbM1my[1]
10:31:42 0:01 0.160u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  memory: 4.6mb/9.2mb/1008.0mb
10:31:42 0:01 0.160u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 4.6mb/9.2mb/504.0mb
10:31:42 0:01 0.160u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy /tmp/magick-XXfbM1my[2]
10:31:42 0:01 0.160u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  memory: 4.6mb/4.6mb/1008.0mb
10:31:42 0:01 0.160u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 4.6mb/4.6mb/504.0mb
10:31:42 0:01 0.160u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy /tmp/magick-XXfbM1my[3]
10:31:42 0:01 0.190u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  memory: 4.6mb/0/1008.0mb
10:31:42 0:01 0.200u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 4.6mb/0/504.0mb
10:31:42 0:01 0.200u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  area: 3.7mb/3.7mb/504.0mb
10:31:42 0:01 0.200u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  memory: 3.7mb/3.7mb/1008.0mb
10:31:42 0:01 0.200u 6.0.7 convert[3538]: cache.c/OpenCache/2372/Cache
  open assets/files/DAL_TEST_IMAGE01.pdf[0] (memory, 3.7mb)
10:31:42 0:01 0.200u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  area: 2.4mb/6.1mb/504.0mb
10:31:42 0:01 0.200u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  memory: 2.4mb/6.1mb/1008.0mb
10:31:42 0:01 0.200u 6.0.7 convert[3538]: cache.c/OpenCache/2372/Cache
  open assets/files/DAL_TEST_IMAGE01.pdf[0] (memory, 2.4mb)
10:31:42 0:01 0.270u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  area: 1.6mb/7.7mb/504.0mb
10:31:42 0:01 0.270u 6.0.7 convert[3538]: resource.c/AcquireMagickResource/209/Resource
  memory: 1.6mb/7.7mb/1008.0mb
10:31:42 0:01 0.270u 6.0.7 convert[3538]: cache.c/OpenCache/2372/Cache
  open assets/files/DAL_TEST_IMAGE01.pdf[0] (memory, 1.6mb)
10:31:42 0:01 0.340u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  memory: 2.4mb/5.3mb/1008.0mb
10:31:42 0:01 0.340u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 2.4mb/5.3mb/504.0mb
10:31:42 0:01 0.340u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy assets/files/DAL_TEST_IMAGE01.pdf[0]
10:31:42 0:01 0.350u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  memory: 3.7mb/1.6mb/1008.0mb
10:31:42 0:01 0.350u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 3.7mb/1.6mb/504.0mb
10:31:42 0:01 0.350u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy assets/files/DAL_TEST_IMAGE01.pdf[0]
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WritePNGImage/7196/Coder
  enter WritePNGImage()
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/5992/Coder
    enter WriteOnePNGImage()
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6057/Coder
      width=400
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6059/Coder
      height=518
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6061/Coder
      image->depth=8
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6101/Coder
      Setting up pHYs chunk
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6324/Coder
      Tentative PNG color type: 2
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6326/Coder
      image_info->type: 0
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6328/Coder
      image->depth: 8
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6330/Coder
      ping_info->bit_depth: 8
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6675/Coder
      PNG color type: 2
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6681/Coder
    Setting up deflate compression
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6685/Coder
      Compression buffer size: 32768
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6690/Coder
      Compression mem level: 9
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6701/Coder
      Compression level: 8
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6713/Coder
    Setting up filtering
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6727/Coder
      Filter_type: 0
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6752/Coder
      Base filter method: NONE
10:31:42 0:01 0.350u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/6832/Coder
    Writing PNG header chunks
10:31:42 0:01 0.460u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/7012/Coder
    Writing PNG image data
10:31:42 0:01 0.460u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/7014/Coder
      Width: 400
10:31:42 0:01 0.460u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/7016/Coder
      Height: 518
10:31:42 0:01 0.460u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/7018/Coder
      PNG sample depth: 8
10:31:42 0:01 0.460u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/7020/Coder
      PNG color type: 2
10:31:42 0:01 0.460u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/7022/Coder
      PNG Interlace method: 0
10:31:42 0:01 0.460u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/7091/Coder
    Writing PNG end info
10:31:42 0:01 0.460u 6.0.7 convert[3538]: png.c/WriteOnePNGImage/7167/Coder
    exit WriteOnePNGImage()
10:31:42 0:01 0.460u 6.0.7 convert[3538]: png.c/WritePNGImage/7223/Coder
  exit WritePNGImage()
10:31:42 0:01 0.460u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  memory: 1.6mb/0/1008.0mb
10:31:42 0:01 0.460u 6.0.7 convert[3538]: resource.c/RelinquishMagickResource/710/Resource
  area: 1.6mb/0/504.0mb
10:31:42 0:01 0.460u 6.0.7 convert[3538]: cache.c/DestroyCacheInfo/1193/Cache
  destroy assets/files/DAL_TEST_IMAGE01.pdf[0]

Could you help me to pinpoint what's wrong with the pdf that generated blank image ?

Many thanks.

Regards,
Sky

Re: Can someone help to analyse the debug trace ?

Posted: 2010-12-22T09:16:03-07:00
by skywalker826
convert -version

Code: Select all

Version: ImageMagick 6.0.7 08/25/10 Q16 http://www.imagemagick.org
Copyright: Copyright (C) 1999-2004 ImageMagick Studio LLC
convert -list type

Code: Select all

Path: /usr/lib/ImageMagick-6.0.7/config/type-ghostscript.mgk

Name                             Family                  Style   Stretch  Weight
--------------------------------------------------------------------------------
AvantGarde-Book                  AvantGarde              Normal  Normal    400
AvantGarde-BookOblique           AvantGarde              Oblique Normal    400
AvantGarde-Demi                  AvantGarde              Normal  Normal    600
AvantGarde-DemiOblique           AvantGarde              Oblique Normal    600
Bookman-Demi                     Bookman                 Normal  Normal    600
Bookman-DemiItalic               Bookman                 Italic  Normal    600
Bookman-Light                    Bookman                 Normal  Normal    300
Bookman-LightItalic              Bookman                 Italic  Normal    300
Courier                          Courier                 Normal  Normal    400
Courier-Bold                     Courier                 Normal  Normal    700
Courier-BoldOblique              Courier                 Oblique Normal    700
Courier-Oblique                  Courier                 Oblique Normal    400
Helvetica                        Helvetica               Normal  Normal    400
Helvetica-Bold                   Helvetica               Normal  Normal    700
Helvetica-BoldOblique            Helvetica               Italic  Normal    700
Helvetica-Narrow                 Helvetica Narrow        Normal  Condensed 400
Helvetica-Narrow-Bold            Helvetica Narrow        Normal  Condensed 700
Helvetica-Narrow-BoldOblique     Helvetica Narrow        Oblique Condensed 700
Helvetica-Narrow-Oblique         Helvetica Narrow        Oblique Condensed 400
Helvetica-Oblique                Helvetica               Italic  Normal    400
NewCenturySchlbk-Bold            NewCenturySchlbk        Normal  Normal    700
NewCenturySchlbk-BoldItalic      NewCenturySchlbk        Italic  Normal    700
NewCenturySchlbk-Italic          NewCenturySchlbk        Italic  Normal    400
NewCenturySchlbk-Roman           NewCenturySchlbk        Normal  Normal    400
Palatino-Bold                    Palatino                Normal  Normal    700
Palatino-BoldItalic              Palatino                Italic  Normal    700
Palatino-Italic                  Palatino                Italic  Normal    400
Palatino-Roman                   Palatino                Normal  Normal    400
Symbol                           Symbol                  Normal  Normal    400
Times-Bold                       Times                   Normal  Normal    700
Times-BoldItalic                 Times                   Italic  Normal    700
Times-Italic                     Times                   Italic  Normal    400
Times-Roman                      Times                   Normal  Normal    400

Re: Can someone help to analyse the debug trace ?

Posted: 2010-12-22T10:24:40-07:00
by fmw42
I cannot help much with the debug trace, but your version of 6.0.7 IM is over 500 versions old. Perhaps it is time to upgrade as there have been many bug fixes and improvements since your version
All times are UTC-07:00
Page 1 of 1

Powered by phpBB® Forum Software © phpBB Limited