You are viewing a plain text version of this content. The canonical link for it is here.
Posted to fop-dev@xmlgraphics.apache.org by Clay Leeds <cl...@medata.com> on 2003/01/23 18:55:05 UTC
FOP 0.20.4 & 5rc timing w large COMMENT sections
Howdy folks,
I have a file where I've commented a fairly large section of my source
XML file (commented areas affect FLOW content--so it won't print out so
many darn pages! :-). I've found significant discrepancies involving the
timing of outputting the commented version vs. the uncommented version.
The intention of this message is to give a heads up (and hopefully
initiate discussion) that there may be discrepancies in rendering time
vs. actual output time when dealing with large comment sections.
Respectfully,
Web Maestro Clay
===
XML file info:
COMMENTED version (1 page of output):
FILENAME - test_NCWC_sm_1.1.XML
FILESIZE - 240 KB (246,218 bytes)
TIME: 01:05 (actual)
TIME: 2000ms (reported rendering time)
UN-COMMENTED version (5 pages of output):
FILENAME - test_NCWC_1.1.XML
FILESIZE - 240 KB (246,213 bytes)
When I processed the COMMENTED version of the file--which printed out a
1 page document--it took 01:05 (1 minute 5 seconds) watching the system
clock, but the DOS output showed ~2000ms:
C:\Program Files\Java\fop-0.20.4>fop -d -xml
C:\xml_med7\biglinux\test_NCWC_sm_1.1.XML -xsl
C:\xml_med7\fo\xml_med7_default.fo -pdf 030123_NCWC_sm_1.1.pdf
[DEBUG] Input mode:
[DEBUG] xslt transformation
[DEBUG] xml input file: C:\xml_med7\biglinux\test_NCWC_sm_1.1.XML
[DEBUG] xslt stylesheet: C:\xml_med7\fo\xml_med7_default.fo
[DEBUG] Output mode:
[DEBUG] pdf
[DEBUG] output file: 030123_NCWC_sm_1.1.pdf
[DEBUG] OPTIONS
[DEBUG] no user configuration file is used [default]
[DEBUG] debug mode on
[DEBUG] dump configuration
[DEBUG] quiet mode on
[DEBUG] Using org.apache.xerces.parsers.SAXParser as SAX2 Parser
[DEBUG] base directory: file:/C:/xml_med7/biglinux/
[INFO] FOP 0.20.4
[DEBUG] Using org.apache.xerces.parsers.SAXParser as SAX2 Parser
[INFO] building formatting object tree
[DEBUG] setting up fonts
[INFO] [1]
[DEBUG] Last page-sequence produced 1 pages.
[INFO] Parsing of document complete, stopping renderer
[DEBUG] Initial heap size: 2525Kb
[DEBUG] Current heap size: 3641Kb
[DEBUG] Total memory used: 1115Kb
[DEBUG] Memory use is indicative; no GC was performed
[DEBUG] These figures should not be used comparatively
[DEBUG] Total time used: 2000ms
[DEBUG] Pages rendered: 1
[DEBUG] Avg render time: 2000ms/page
C:\Program Files\Java\fop-0.20.4>
====
It took 2 seconds of rendering time compared to 65 seconds of time taken
from command line [Enter] to FOP output completion. But when I run the
normal un-COMMENTED version, it now took 15 seconds. However, the DOS
window showed:
C:\Program Files\Java\fop-0.20.4>fop -d -xml
C:\xml_med7\biglinux\test_NCWC_1.1.XML -xsl
C:\xml_med7\fo\xml_med7_default.fo -pdf 030123_NCWC_1.1.pdf
[DEBUG] Input mode:
[DEBUG] xslt transformation
[DEBUG] xml input file: C:\xml_med7\biglinux\test_NCWC_1.1.XML
[DEBUG] xslt stylesheet: C:\xml_med7\fo\xml_med7_default.fo
[DEBUG] Output mode:
[DEBUG] pdf
[DEBUG] output file: 030123_NCWC_1.1.pdf
[DEBUG] OPTIONS
[DEBUG] no user configuration file is used [default]
[DEBUG] debug mode on
[DEBUG] dump configuration
[DEBUG] quiet mode on
[DEBUG] Using org.apache.xerces.parsers.SAXParser as SAX2 Parser
[DEBUG] base directory: file:/C:/xml_med7/biglinux/
[INFO] FOP 0.20.4
[DEBUG] Using org.apache.xerces.parsers.SAXParser as SAX2 Parser
[INFO] building formatting object tree
[DEBUG] setting up fonts
[INFO] [1]
[INFO] [2]
[INFO] [3]
[INFO] [4]
[INFO] [5]
[DEBUG] Last page-sequence produced 5 pages.
[INFO] Parsing of document complete, stopping renderer
[DEBUG] Initial heap size: 2666Kb
[DEBUG] Current heap size: 15561Kb
[DEBUG] Total memory used: 12894Kb
[DEBUG] Memory use is indicative; no GC was performed
[DEBUG] These figures should not be used comparatively
[DEBUG] Total time used: 9609ms
[DEBUG] Pages rendered: 5
[DEBUG] Avg render time: 1921ms/page
C:\Program Files\Java\fop-0.20.4>
====
Both times it appeared to "hang" on "[DEBUG] Using
org.apache.xerces.parsers.SAXParser as SAX2 Parser".
In FOP's defense, I noticed the last line refers to "Avg render time:"
BTW, I also tried this with 0.20.5rc and here're my results.
COMMENTED version (00:58 seconds):
C:\Program Files\Java\fop-0.20.5rc>fop -d -xml
C:\xml_med7\biglinux\test_NCWC_sm_1.1.XML -xsl
C:\xml_med7\fo\xml_med7_default.fo -pdf 030123_NCWC_sm_1.1.pdf
[DEBUG] Input mode:
[DEBUG] xslt transformation
[DEBUG] xml input file: C:\xml_med7\biglinux\test_NCWC_sm_1.1.XML
[DEBUG] xslt stylesheet: C:\xml_med7\fo\xml_med7_default.fo
[DEBUG] Output mode:
[DEBUG] pdf
[DEBUG] output file: 030123_NCWC_sm_1.1.pdf
[DEBUG] OPTIONS
[DEBUG] no user configuration file is used [default]
[DEBUG] debug mode on
[DEBUG] dump configuration
[DEBUG] quiet mode on
[INFO] Using org.apache.xerces.parsers.SAXParser as SAX2 Parser
[INFO] base directory: file:/C:/xml_med7/biglinux/
[INFO] FOP 0.20.5rc
[INFO] Using org.apache.xerces.parsers.SAXParser as SAX2 Parser
[INFO] building formatting object tree
[INFO] setting up fonts
[INFO] [1]
[DEBUG] Last page-sequence produced 1 pages.
[INFO] Parsing of document complete, stopping renderer
[DEBUG] Initial heap size: 3674Kb
[DEBUG] Current heap size: 4765Kb
[DEBUG] Total memory used: 1090Kb
[DEBUG] Memory use is indicative; no GC was performed
[DEBUG] These figures should not be used comparatively
[DEBUG] Total time used: 1687ms
[DEBUG] Pages rendered: 1
[DEBUG] Avg render time: 1687ms/page
C:\Program Files\Java\fop-0.20.5rc>
====
UNCOMMENTED version (00:09 seconds):
C:\Program Files\Java\fop-0.20.5rc>fop -d -xml
C:\xml_med7\biglinux\test_NCWC_1.1.XML -xsl
C:\xml_med7\fo\xml_med7_default.fo -pdf 030123_NCWC_1.1.pdf
[DEBUG] Input mode:
[DEBUG] xslt transformation
[DEBUG] xml input file: C:\xml_med7\biglinux\test_NCWC_1.1.XML
[DEBUG] xslt stylesheet: C:\xml_med7\fo\xml_med7_default.fo
[DEBUG] Output mode:
[DEBUG] pdf
[DEBUG] output file: 030123_NCWC_1.1.pdf
[DEBUG] OPTIONS
[DEBUG] no user configuration file is used [default]
[DEBUG] debug mode on
[DEBUG] dump configuration
[DEBUG] quiet mode on
[INFO] Using org.apache.xerces.parsers.SAXParser as SAX2 Parser
[INFO] base directory: file:/C:/xml_med7/biglinux/
[INFO] FOP 0.20.5rc
[INFO] Using org.apache.xerces.parsers.SAXParser as SAX2 Parser
[INFO] building formatting object tree
[INFO] setting up fonts
[INFO] [1]
[INFO] [2]
[INFO] [3]
[INFO] [4]
[INFO] [5]
[DEBUG] Last page-sequence produced 5 pages.
[INFO] Parsing of document complete, stopping renderer
[DEBUG] Initial heap size: 3384Kb
[DEBUG] Current heap size: 13805Kb
[DEBUG] Total memory used: 10421Kb
[DEBUG] Memory use is indicative; no GC was performed
[DEBUG] These figures should not be used comparatively
[DEBUG] Total time used: 8344ms
[DEBUG] Pages rendered: 5
[DEBUG] Avg render time: 1668ms/page
C:\Program Files\Java\fop-0.20.5rc>
====
As you can see, the 0.20.5rc output is significantly quicker (the DOS
output window for the UNCOMMENTED version virtually matched the actual
processing time 8344ms vs ~9 secs). However, the COMMENTED version
difference was significant.
Any thoughts?
Web Maestro Clay
---------------------------------------------------------------------
To unsubscribe, e-mail: fop-dev-unsubscribe@xml.apache.org
For additional commands, email: fop-dev-help@xml.apache.org
Re: FOP 0.20.4 & 5rc timing w large COMMENT sections
Posted by "J.Pietschmann" <j3...@yahoo.de>.
Clay Leeds wrote:
> It took 2 seconds of rendering time compared to 65 seconds of time taken
> from command line [Enter] to FOP output completion.
This latter time includes JVM startup, loading all the code and
whatnot. Occasionally the OS is busy and it takes longer to load
an executable and the data.
How often did you execute the experiment?
If you want to have more accurate measurements you should install
cygwin and use the time command.
J.Pietschmann
---------------------------------------------------------------------
To unsubscribe, e-mail: fop-dev-unsubscribe@xml.apache.org
For additional commands, email: fop-dev-help@xml.apache.org