From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: (qmail 28724 invoked by alias); 6 Nov 2009 16:48:01 -0000 Received: (qmail 28328 invoked by uid 22791); 6 Nov 2009 16:47:53 -0000 X-SWARE-Spam-Status: No, hits=0.1 required=5.0 tests=AWL,BAYES_50,KAM_TIME X-Spam-Check-By: sourceware.org Received: from smtp-105-friday.noc.nerim.net (HELO mallaury.nerim.net) (62.4.17.105) by sourceware.org (qpsmtpd/0.43rc1) with ESMTP; Fri, 06 Nov 2009 16:47:44 +0000 Received: from hector.lesours (ours.starynkevitch.net [213.41.244.95]) by mallaury.nerim.net (Postfix) with ESMTP id 468E3A1092; Fri, 6 Nov 2009 17:47:40 +0100 (CET) Received: from [192.168.0.1] by hector.lesours with esmtp (Exim 4.69) (envelope-from ) id 1N6RyI-0005YR-I6; Fri, 06 Nov 2009 17:47:34 +0100 Message-ID: <4AF45320.1010704@starynkevitch.net> Date: Fri, 06 Nov 2009 16:48:00 -0000 From: Basile STARYNKEVITCH User-Agent: Mozilla-Thunderbird 2.0.0.22 (X11/20090701) MIME-Version: 1.0 To: Ian Lance Taylor CC: Dave Korn , GCC Mailing List Subject: Re: very different compilation times [no optimisation] References: <4AF43ADB.3080503@starynkevitch.net> <4AF443FB.6060206@starynkevitch.net> <4AF44904.4040105@gmail.com> In-Reply-To: Content-Type: text/plain; charset=ISO-8859-1; format=flowed Content-Transfer-Encoding: 7bit X-IsSubscribed: yes Mailing-List: contact gcc-help@gcc.gnu.org; run by ezmlm Precedence: bulk List-Id: List-Archive: List-Post: List-Help: Sender: gcc-owner@gcc.gnu.org X-SW-Source: 2009-11/txt/msg00145.txt.bz2 Ian Lance Taylor wrote: > Basile, you posted the time for the wrong file, or you got something > else wrong. Here are other runs. The warmelt-normal-1.i is exactly the one uploaded in the bug report. Its md5sum is 944b6e0f8c6da76a7f0698e927fc4a60 warmelt-normal-1.i And it does not seem to be some excess swapping. The cc1 process seems to eat half a gigabyte, and I have 8 gigabytes (and mozilla, emacs, thunderbird don't eat all of them). During a cc1 % free total used free shared buffers cached Mem: 8197136 5181216 3015920 0 1435412 1777752 -/+ buffers/cache: 1968052 6229084 Swap: 15141244 0 15141244 I checked on my wristwatch and the real timing is similar to the one reported by the computer (so its hardware clock is apparently ok). ################ gcc 4.3 glinka ~/tmp 17:05 % time gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3.o # cc1 18.90 0.97 # as 0.74 0.04 gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3. 19.64s user 1.02s system 99% cpu 20.839 total glinka ~/tmp 17:06 % time gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3.o # cc1 6.36 0.28 # as 0.74 0.05 gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3. 7.10s user 0.33s system 99% cpu 7.440 total glinka ~/tmp 17:06 % time gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3.o # cc1 8.78 0.67 # as 0.72 0.05 gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3. 9.50s user 0.72s system 98% cpu 10.337 total glinka ~/tmp 17:06 % glinka ~/tmp 17:06 % time gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3.o # cc1 6.28 0.34 # as 0.73 0.03 gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3. 7.01s user 0.37s system 99% cpu 7.401 total glinka ~/tmp 17:06 % time gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3.o # cc1 67.33 2.92 # as 7.54 0.49 gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3. 74.88s user 3.44s system 99% cpu 1:18.92 total glinka ~/tmp 17:11 % time gcc-4.3 -ftime-report -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3.o Execution times (seconds) garbage collection : 0.10 ( 1%) usr 0.00 ( 0%) sys 0.10 ( 1%) wall 0 kB ( 0%) ggc cfg cleanup : 0.07 ( 1%) usr 0.00 ( 0%) sys 0.06 ( 1%) wall 19 kB ( 0%) ggc trivially dead code : 0.05 ( 1%) usr 0.00 ( 0%) sys 0.05 ( 1%) wall 0 kB ( 0%) ggc df live regs : 0.10 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 0 kB ( 0%) ggc df reg dead/unused notes: 0.07 ( 1%) usr 0.00 ( 0%) sys 0.08 ( 1%) wall 6838 kB ( 2%) ggc register information : 0.10 ( 1%) usr 0.00 ( 0%) sys 0.09 ( 1%) wall 0 kB ( 0%) ggc alias analysis : 0.04 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 2315 kB ( 1%) ggc rebuild jump labels : 0.05 ( 1%) usr 0.00 ( 0%) sys 0.04 ( 0%) wall 0 kB ( 0%) ggc preprocessing : 0.42 ( 6%) usr 0.22 (17%) sys 0.65 ( 8%) wall 24801 kB ( 7%) ggc lexical analysis : 0.18 ( 3%) usr 0.57 (44%) sys 0.64 ( 8%) wall 0 kB ( 0%) ggc parser : 0.86 (13%) usr 0.30 (23%) sys 1.29 (16%) wall 100081 kB (28%) ggc inline heuristics : 0.21 ( 3%) usr 0.01 ( 1%) sys 0.23 ( 3%) wall 70 kB ( 0%) ggc tree gimplify : 0.44 ( 7%) usr 0.03 ( 2%) sys 0.44 ( 5%) wall 58497 kB (16%) ggc tree eh : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.03 ( 0%) wall 0 kB ( 0%) ggc tree CFG construction : 0.07 ( 1%) usr 0.03 ( 2%) sys 0.10 ( 1%) wall 37602 kB (10%) ggc tree CFG cleanup : 0.08 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 0 kB ( 0%) ggc dominance computation : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.04 ( 0%) wall 0 kB ( 0%) ggc expand : 1.39 (21%) usr 0.05 ( 4%) sys 1.41 (18%) wall 89051 kB (24%) ggc varconst : 0.01 ( 0%) usr 0.00 ( 0%) sys 0.01 ( 0%) wall 92 kB ( 0%) ggc jump : 0.01 ( 0%) usr 0.00 ( 0%) sys 0.00 ( 0%) wall 0 kB ( 0%) ggc local alloc : 0.55 ( 8%) usr 0.00 ( 0%) sys 0.61 ( 8%) wall 3032 kB ( 1%) ggc global alloc : 1.22 (18%) usr 0.05 ( 4%) sys 1.25 (16%) wall 18079 kB ( 5%) ggc thread pro- & epilogue: 0.11 ( 2%) usr 0.00 ( 0%) sys 0.13 ( 2%) wall 256 kB ( 0%) ggc final : 0.43 ( 6%) usr 0.03 ( 2%) sys 0.45 ( 6%) wall 360 kB ( 0%) ggc symout : 0.10 ( 1%) usr 0.01 ( 1%) sys 0.11 ( 1%) wall 21440 kB ( 6%) ggc TOTAL : 6.73 1.30 8.05 363506 kB gcc-4.3 -ftime-report -O0 -g -fPIC warmelt-normal-1.i -c -o 7.47s user 1.36s system 99% cpu 8.846 total glinka ~/tmp 17:12 % time gcc-4.3 -ftime-report -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.3.o Execution times (seconds) garbage collection : 0.99 ( 2%) usr 0.00 ( 0%) sys 0.99 ( 1%) wall 0 kB ( 0%) ggc cfg cleanup : 0.58 ( 1%) usr 0.00 ( 0%) sys 0.62 ( 1%) wall 19 kB ( 0%) ggc trivially dead code : 0.41 ( 1%) usr 0.00 ( 0%) sys 0.40 ( 1%) wall 0 kB ( 0%) ggc df live regs : 0.71 ( 1%) usr 0.02 ( 0%) sys 0.73 ( 1%) wall 0 kB ( 0%) ggc df reg dead/unused notes: 0.87 ( 1%) usr 0.01 ( 0%) sys 0.78 ( 1%) wall 6838 kB ( 2%) ggc register information : 0.84 ( 1%) usr 0.00 ( 0%) sys 0.90 ( 1%) wall 0 kB ( 0%) ggc alias analysis : 0.42 ( 1%) usr 0.00 ( 0%) sys 0.48 ( 1%) wall 2315 kB ( 1%) ggc rebuild jump labels : 0.59 ( 1%) usr 0.00 ( 0%) sys 0.59 ( 1%) wall 0 kB ( 0%) ggc preprocessing : 4.16 ( 6%) usr 2.28 (22%) sys 6.49 ( 9%) wall 24801 kB ( 7%) ggc lexical analysis : 1.59 ( 2%) usr 3.88 (37%) sys 5.62 ( 7%) wall 0 kB ( 0%) ggc parser : 7.16 (11%) usr 2.70 (26%) sys 9.69 (13%) wall 100081 kB (28%) ggc inline heuristics : 2.02 ( 3%) usr 0.05 ( 0%) sys 2.12 ( 3%) wall 70 kB ( 0%) ggc tree gimplify : 4.39 ( 7%) usr 0.33 ( 3%) sys 4.68 ( 6%) wall 58497 kB (16%) ggc tree eh : 0.23 ( 0%) usr 0.00 ( 0%) sys 0.21 ( 0%) wall 0 kB ( 0%) ggc tree CFG construction : 0.85 ( 1%) usr 0.10 ( 1%) sys 1.00 ( 1%) wall 37602 kB (10%) ggc tree CFG cleanup : 0.55 ( 1%) usr 0.00 ( 0%) sys 0.55 ( 1%) wall 0 kB ( 0%) ggc dominance computation : 0.21 ( 0%) usr 0.02 ( 0%) sys 0.28 ( 0%) wall 0 kB ( 0%) ggc expand : 13.40 (21%) usr 0.66 ( 6%) sys 14.22 (19%) wall 89051 kB (24%) ggc varconst : 0.06 ( 0%) usr 0.02 ( 0%) sys 0.03 ( 0%) wall 92 kB ( 0%) ggc jump : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.04 ( 0%) wall 0 kB ( 0%) ggc local alloc : 6.01 ( 9%) usr 0.06 ( 1%) sys 5.94 ( 8%) wall 3032 kB ( 1%) ggc global alloc : 12.39 (19%) usr 0.14 ( 1%) sys 12.66 (17%) wall 18079 kB ( 5%) ggc thread pro- & epilogue: 1.05 ( 2%) usr 0.00 ( 0%) sys 1.16 ( 2%) wall 256 kB ( 0%) ggc final : 4.01 ( 6%) usr 0.19 ( 2%) sys 4.20 ( 6%) wall 360 kB ( 0%) ggc symout : 1.05 ( 2%) usr 0.07 ( 1%) sys 1.14 ( 2%) wall 21440 kB ( 6%) ggc TOTAL : 64.60 10.53 75.56 363506 kB gcc-4.3 -ftime-report -O0 -g -fPIC warmelt-normal-1.i -c -o 70.82s user 11.11s system 99% cpu 1:22.40 total ################### gcc 4.4 glinka ~/tmp 17:15 % time gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4.o # cc1 14.78 0.84 # as 0.75 0.04 gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4. 15.53s user 0.89s system 99% cpu 16.498 total glinka ~/tmp 17:15 % time gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4.o # cc1 71.20 2.06 # as 7.70 0.51 gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4. 78.90s user 2.60s system 99% cpu 1:21.71 total glinka ~/tmp 17:17 % time gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4.o # cc1 85.06 2.72 # as 7.83 0.47 gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4. 92.89s user 3.23s system 99% cpu 1:36.72 total glinka ~/tmp 17:20 % time gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4.o # cc1 49.80 2.12 # as 0.75 0.03 gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4. 50.56s user 2.16s system 99% cpu 52.947 total glinka ~/tmp 17:20 % time gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4.o # cc1 34.11 1.02 # as 7.68 0.54 gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4. 41.79s user 1.59s system 99% cpu 43.733 total glinka ~/tmp 17:21 % time gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4.o # cc1 84.43 2.72 # as 7.77 0.44 gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4. 92.21s user 3.19s system 99% cpu 1:35.87 total glinka ~/tmp 17:23 % time gcc-4.4 -ftime-report -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4.o Execution times (seconds) garbage collection : 1.08 ( 1%) usr 0.01 ( 0%) sys 1.09 ( 1%) wall 0 kB ( 0%) ggc callgraph construction: 2.81 ( 3%) usr 0.12 ( 1%) sys 2.97 ( 3%) wall 13570 kB ( 3%) ggc callgraph optimization: 0.46 ( 1%) usr 0.00 ( 0%) sys 0.50 ( 0%) wall 339 kB ( 0%) ggc cfg cleanup : 0.46 ( 1%) usr 0.00 ( 0%) sys 0.48 ( 0%) wall 24 kB ( 0%) ggc trivially dead code : 0.86 ( 1%) usr 0.00 ( 0%) sys 0.81 ( 1%) wall 0 kB ( 0%) ggc df live regs : 0.79 ( 1%) usr 0.02 ( 0%) sys 0.72 ( 1%) wall 0 kB ( 0%) ggc df reg dead/unused notes: 1.49 ( 2%) usr 0.03 ( 0%) sys 1.64 ( 2%) wall 6956 kB ( 2%) ggc register information : 0.92 ( 1%) usr 0.01 ( 0%) sys 0.88 ( 1%) wall 0 kB ( 0%) ggc alias analysis : 0.43 ( 0%) usr 0.00 ( 0%) sys 0.48 ( 0%) wall 2405 kB ( 1%) ggc rebuild jump labels : 0.58 ( 1%) usr 0.00 ( 0%) sys 0.60 ( 1%) wall 0 kB ( 0%) ggc preprocessing : 4.75 ( 5%) usr 2.84 (21%) sys 7.58 ( 7%) wall 25440 kB ( 6%) ggc lexical analysis : 2.06 ( 2%) usr 5.45 (39%) sys 7.28 ( 7%) wall 0 kB ( 0%) ggc parser : 6.08 ( 7%) usr 3.18 (23%) sys 9.44 ( 9%) wall 71977 kB (17%) ggc inline heuristics : 0.50 ( 1%) usr 0.02 ( 0%) sys 0.49 ( 0%) wall 0 kB ( 0%) ggc tree gimplify : 10.00 (11%) usr 0.38 ( 3%) sys 10.58 (10%) wall 88334 kB (21%) ggc tree eh : 0.18 ( 0%) usr 0.00 ( 0%) sys 0.20 ( 0%) wall 0 kB ( 0%) ggc tree CFG construction : 0.54 ( 1%) usr 0.05 ( 0%) sys 0.62 ( 1%) wall 13199 kB ( 3%) ggc tree CFG cleanup : 0.66 ( 1%) usr 0.00 ( 0%) sys 0.56 ( 1%) wall 0 kB ( 0%) ggc tree find ref. vars : 0.43 ( 0%) usr 0.05 ( 0%) sys 0.55 ( 1%) wall 9130 kB ( 2%) ggc tree PHI insertion : 0.12 ( 0%) usr 0.00 ( 0%) sys 0.14 ( 0%) wall 189 kB ( 0%) ggc tree SSA rewrite : 0.19 ( 0%) usr 0.05 ( 0%) sys 0.24 ( 0%) wall 11835 kB ( 3%) ggc tree SSA other : 0.76 ( 1%) usr 0.24 ( 2%) sys 1.05 ( 1%) wall 193 kB ( 0%) ggc tree operand scan : 0.58 ( 1%) usr 0.27 ( 2%) sys 0.77 ( 1%) wall 7012 kB ( 2%) ggc tree SSA to normal : 1.08 ( 1%) usr 0.00 ( 0%) sys 1.01 ( 1%) wall 448 kB ( 0%) ggc dominance frontiers : 0.01 ( 0%) usr 0.00 ( 0%) sys 0.01 ( 0%) wall 0 kB ( 0%) ggc dominance computation : 0.44 ( 0%) usr 0.01 ( 0%) sys 0.41 ( 0%) wall 0 kB ( 0%) ggc expand : 17.52 (20%) usr 0.39 ( 3%) sys 18.22 (18%) wall 131397 kB (31%) ggc varconst : 0.00 ( 0%) usr 0.00 ( 0%) sys 0.01 ( 0%) wall 24 kB ( 0%) ggc jump : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.02 ( 0%) wall 0 kB ( 0%) ggc integrated RA : 16.00 (18%) usr 0.11 ( 1%) sys 16.10 (16%) wall 3144 kB ( 1%) ggc reload : 9.56 (11%) usr 0.17 ( 1%) sys 9.74 ( 9%) wall 17800 kB ( 4%) ggc thread pro- & epilogue: 1.44 ( 2%) usr 0.00 ( 0%) sys 1.51 ( 1%) wall 342 kB ( 0%) ggc final : 4.81 ( 5%) usr 0.26 ( 2%) sys 5.04 ( 5%) wall 2487 kB ( 1%) ggc symout : 1.17 ( 1%) usr 0.09 ( 1%) sys 1.29 ( 1%) wall 22415 kB ( 5%) ggc rest of compilation : 0.01 ( 0%) usr 0.00 ( 0%) sys 0.00 ( 0%) wall 0 kB ( 0%) ggc TOTAL : 88.87 13.85 103.23 429820 kB gcc-4.4 -ftime-report -O0 -g -fPIC warmelt-normal-1.i -c -o 96.57s user 14.64s system 99% cpu 1:51.80 total glinka ~/tmp 17:25 % time gcc-4.4 -ftime-report -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4.o Execution times (seconds) garbage collection : 1.07 ( 2%) usr 0.00 ( 0%) sys 1.08 ( 1%) wall 0 kB ( 0%) ggc callgraph construction: 2.78 ( 5%) usr 0.08 ( 1%) sys 2.95 ( 4%) wall 13570 kB ( 3%) ggc callgraph optimization: 0.44 ( 1%) usr 0.00 ( 0%) sys 0.46 ( 1%) wall 339 kB ( 0%) ggc cfg cleanup : 0.11 ( 0%) usr 0.00 ( 0%) sys 0.12 ( 0%) wall 24 kB ( 0%) ggc trivially dead code : 0.56 ( 1%) usr 0.00 ( 0%) sys 0.48 ( 1%) wall 0 kB ( 0%) ggc df live regs : 0.30 ( 0%) usr 0.00 ( 0%) sys 0.33 ( 0%) wall 0 kB ( 0%) ggc df reg dead/unused notes: 0.67 ( 1%) usr 0.00 ( 0%) sys 0.72 ( 1%) wall 6956 kB ( 2%) ggc register information : 0.44 ( 1%) usr 0.00 ( 0%) sys 0.45 ( 1%) wall 0 kB ( 0%) ggc alias analysis : 0.31 ( 1%) usr 0.00 ( 0%) sys 0.29 ( 0%) wall 2405 kB ( 1%) ggc rebuild jump labels : 0.34 ( 1%) usr 0.00 ( 0%) sys 0.33 ( 0%) wall 0 kB ( 0%) ggc preprocessing : 4.59 ( 7%) usr 2.77 (21%) sys 7.63 (10%) wall 25440 kB ( 6%) ggc lexical analysis : 2.11 ( 3%) usr 5.31 (40%) sys 7.55 (10%) wall 0 kB ( 0%) ggc parser : 6.32 (10%) usr 3.19 (24%) sys 9.15 (12%) wall 71977 kB (17%) ggc inline heuristics : 0.48 ( 1%) usr 0.00 ( 0%) sys 0.49 ( 1%) wall 0 kB ( 0%) ggc tree gimplify : 9.69 (16%) usr 0.55 ( 4%) sys 10.26 (14%) wall 88334 kB (21%) ggc tree eh : 0.22 ( 0%) usr 0.01 ( 0%) sys 0.18 ( 0%) wall 0 kB ( 0%) ggc tree CFG construction : 0.56 ( 1%) usr 0.06 ( 0%) sys 0.64 ( 1%) wall 13199 kB ( 3%) ggc tree CFG cleanup : 0.53 ( 1%) usr 0.01 ( 0%) sys 0.56 ( 1%) wall 0 kB ( 0%) ggc tree find ref. vars : 0.46 ( 1%) usr 0.03 ( 0%) sys 0.51 ( 1%) wall 9130 kB ( 2%) ggc tree PHI insertion : 0.12 ( 0%) usr 0.01 ( 0%) sys 0.09 ( 0%) wall 189 kB ( 0%) ggc tree SSA rewrite : 0.21 ( 0%) usr 0.07 ( 1%) sys 0.34 ( 0%) wall 11835 kB ( 3%) ggc tree SSA other : 0.72 ( 1%) usr 0.19 ( 1%) sys 0.92 ( 1%) wall 193 kB ( 0%) ggc tree operand scan : 0.65 ( 1%) usr 0.29 ( 2%) sys 0.86 ( 1%) wall 7012 kB ( 2%) ggc tree SSA to normal : 0.49 ( 1%) usr 0.00 ( 0%) sys 0.43 ( 1%) wall 448 kB ( 0%) ggc dominance frontiers : 0.02 ( 0%) usr 0.00 ( 0%) sys 0.02 ( 0%) wall 0 kB ( 0%) ggc dominance computation : 0.35 ( 1%) usr 0.02 ( 0%) sys 0.38 ( 1%) wall 0 kB ( 0%) ggc expand : 10.54 (17%) usr 0.25 ( 2%) sys 10.81 (14%) wall 131397 kB (31%) ggc varconst : 0.02 ( 0%) usr 0.02 ( 0%) sys 0.01 ( 0%) wall 24 kB ( 0%) ggc jump : 0.02 ( 0%) usr 0.00 ( 0%) sys 0.00 ( 0%) wall 0 kB ( 0%) ggc integrated RA : 8.97 (15%) usr 0.06 ( 0%) sys 9.20 (12%) wall 3144 kB ( 1%) ggc reload : 4.19 ( 7%) usr 0.05 ( 0%) sys 4.28 ( 6%) wall 17800 kB ( 4%) ggc thread pro- & epilogue: 0.54 ( 1%) usr 0.00 ( 0%) sys 0.60 ( 1%) wall 342 kB ( 0%) ggc final : 2.42 ( 4%) usr 0.19 ( 1%) sys 2.48 ( 3%) wall 2487 kB ( 1%) ggc symout : 0.25 ( 0%) usr 0.02 ( 0%) sys 0.42 ( 1%) wall 22415 kB ( 5%) ggc TOTAL : 61.55 13.28 75.18 429820 kB gcc-4.4 -ftime-report -O0 -g -fPIC warmelt-normal-1.i -c -o 62.30s user 13.36s system 99% cpu 1:16.00 total glinka ~/tmp 17:27 % time gcc-4.4 -ftime-report -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-1-gcc-4.4.o Execution times (seconds) garbage collection : 1.07 ( 3%) usr 0.00 ( 0%) sys 1.08 ( 2%) wall 0 kB ( 0%) ggc callgraph construction: 2.75 ( 7%) usr 0.08 ( 2%) sys 2.92 ( 6%) wall 13570 kB ( 3%) ggc callgraph optimization: 0.45 ( 1%) usr 0.00 ( 0%) sys 0.47 ( 1%) wall 339 kB ( 0%) ggc cfg cleanup : 0.08 ( 0%) usr 0.00 ( 0%) sys 0.12 ( 0%) wall 24 kB ( 0%) ggc trivially dead code : 0.42 ( 1%) usr 0.00 ( 0%) sys 0.42 ( 1%) wall 0 kB ( 0%) ggc df live regs : 0.35 ( 1%) usr 0.00 ( 0%) sys 0.35 ( 1%) wall 0 kB ( 0%) ggc df reg dead/unused notes: 0.57 ( 1%) usr 0.00 ( 0%) sys 0.66 ( 1%) wall 6956 kB ( 2%) ggc register information : 0.29 ( 1%) usr 0.00 ( 0%) sys 0.28 ( 1%) wall 0 kB ( 0%) ggc alias analysis : 0.18 ( 0%) usr 0.00 ( 0%) sys 0.18 ( 0%) wall 2405 kB ( 1%) ggc rebuild jump labels : 0.32 ( 1%) usr 0.00 ( 0%) sys 0.31 ( 1%) wall 0 kB ( 0%) ggc preprocessing : 0.88 ( 2%) usr 0.64 (16%) sys 1.56 ( 3%) wall 25440 kB ( 6%) ggc lexical analysis : 0.53 ( 1%) usr 1.14 (29%) sys 1.80 ( 4%) wall 0 kB ( 0%) ggc parser : 1.45 ( 3%) usr 0.72 (18%) sys 2.04 ( 4%) wall 71977 kB (17%) ggc inline heuristics : 0.45 ( 1%) usr 0.00 ( 0%) sys 0.45 ( 1%) wall 0 kB ( 0%) ggc tree gimplify : 2.68 ( 6%) usr 0.22 ( 6%) sys 2.88 ( 6%) wall 88334 kB (21%) ggc tree eh : 0.18 ( 0%) usr 0.00 ( 0%) sys 0.20 ( 0%) wall 0 kB ( 0%) ggc tree CFG construction : 0.68 ( 2%) usr 0.04 ( 1%) sys 0.61 ( 1%) wall 13199 kB ( 3%) ggc tree CFG cleanup : 0.56 ( 1%) usr 0.00 ( 0%) sys 0.58 ( 1%) wall 0 kB ( 0%) ggc tree find ref. vars : 0.52 ( 1%) usr 0.02 ( 1%) sys 0.54 ( 1%) wall 9130 kB ( 2%) ggc tree PHI insertion : 0.09 ( 0%) usr 0.00 ( 0%) sys 0.11 ( 0%) wall 189 kB ( 0%) ggc tree SSA rewrite : 0.23 ( 1%) usr 0.04 ( 1%) sys 0.27 ( 1%) wall 11835 kB ( 3%) ggc tree SSA other : 0.57 ( 1%) usr 0.20 ( 5%) sys 1.01 ( 2%) wall 193 kB ( 0%) ggc tree operand scan : 0.71 ( 2%) usr 0.37 ( 9%) sys 0.81 ( 2%) wall 7012 kB ( 2%) ggc tree SSA to normal : 0.42 ( 1%) usr 0.00 ( 0%) sys 0.45 ( 1%) wall 448 kB ( 0%) ggc dominance frontiers : 0.01 ( 0%) usr 0.00 ( 0%) sys 0.03 ( 0%) wall 0 kB ( 0%) ggc dominance computation : 0.25 ( 1%) usr 0.03 ( 1%) sys 0.33 ( 1%) wall 0 kB ( 0%) ggc expand : 10.54 (25%) usr 0.21 ( 5%) sys 10.63 (23%) wall 131397 kB (31%) ggc varconst : 0.00 ( 0%) usr 0.01 ( 0%) sys 0.00 ( 0%) wall 24 kB ( 0%) ggc jump : 0.04 ( 0%) usr 0.00 ( 0%) sys 0.03 ( 0%) wall 0 kB ( 0%) ggc integrated RA : 7.38 (18%) usr 0.01 ( 0%) sys 7.45 (16%) wall 3144 kB ( 1%) ggc reload : 4.11 (10%) usr 0.01 ( 0%) sys 4.06 ( 9%) wall 17800 kB ( 4%) ggc thread pro- & epilogue: 0.59 ( 1%) usr 0.00 ( 0%) sys 0.58 ( 1%) wall 342 kB ( 0%) ggc reg stack : 0.00 ( 0%) usr 0.01 ( 0%) sys 0.00 ( 0%) wall 0 kB ( 0%) ggc final : 2.38 ( 6%) usr 0.15 ( 4%) sys 2.50 ( 5%) wall 2487 kB ( 1%) ggc symout : 0.25 ( 1%) usr 0.03 ( 1%) sys 0.26 ( 1%) wall 22415 kB ( 5%) ggc TOTAL : 42.02 3.93 46.03 429820 kB gcc-4.4 -ftime-report -O0 -g -fPIC warmelt-normal-1.i -c -o 42.77s user 3.99s system 99% cpu 46.832 total #### The widely different figures from one run to the next are surprising. Here are the figures on my laptop Ubuntu Karmic AMD64 (dual-core Intel Core 2 P9500 at 2.53Ghz) time gcc-4.2 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.2.o # cc1 5.39 0.31 # as 0.74 0.07 gcc-4.2 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.2.o 6.13s user 0.38s system 99% cpu 6.525 total time gcc-4.2 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.2.o # cc1 5.35 0.35 # as 0.75 0.05 gcc-4.2 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.2.o 6.10s user 0.41s system 100% cpu 6.508 total time gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.3.o # cc1 6.79 0.36 # as 0.79 0.03 gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.3.o 7.58s user 0.39s system 99% cpu 7.995 total time gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.3.o # cc1 6.80 0.31 # as 0.77 0.06 gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.3.o 7.57s user 0.37s system 99% cpu 7.965 total time gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.3.o -ftime-report Execution times (seconds) garbage collection : 0.10 ( 1%) usr 0.00 ( 0%) sys 0.10 ( 1%) wall 0 kB ( 0%) ggc cfg cleanup : 0.04 ( 1%) usr 0.00 ( 0%) sys 0.04 ( 0%) wall 19 kB ( 0%) ggc trivially dead code : 0.05 ( 1%) usr 0.00 ( 0%) sys 0.05 ( 1%) wall 0 kB ( 0%) ggc df live regs : 0.09 ( 1%) usr 0.00 ( 0%) sys 0.09 ( 1%) wall 0 kB ( 0%) ggc df reg dead/unused notes: 0.07 ( 1%) usr 0.02 ( 2%) sys 0.09 ( 1%) wall 6838 kB ( 2%) ggc register information : 0.08 ( 1%) usr 0.01 ( 1%) sys 0.09 ( 1%) wall 0 kB ( 0%) ggc alias analysis : 0.04 ( 1%) usr 0.00 ( 0%) sys 0.04 ( 0%) wall 2315 kB ( 1%) ggc rebuild jump labels : 0.05 ( 1%) usr 0.00 ( 0%) sys 0.05 ( 1%) wall 0 kB ( 0%) ggc preprocessing : 0.42 ( 6%) usr 0.17 (15%) sys 0.57 ( 7%) wall 24801 kB ( 7%) ggc lexical analysis : 0.24 ( 3%) usr 0.39 (35%) sys 0.64 ( 8%) wall 0 kB ( 0%) ggc parser : 1.00 (14%) usr 0.19 (17%) sys 1.20 (15%) wall 100143 kB (28%) ggc inline heuristics : 0.21 ( 3%) usr 0.01 ( 1%) sys 0.22 ( 3%) wall 70 kB ( 0%) ggc tree gimplify : 0.53 ( 7%) usr 0.04 ( 4%) sys 0.57 ( 7%) wall 58497 kB (16%) ggc tree eh : 0.02 ( 0%) usr 0.00 ( 0%) sys 0.02 ( 0%) wall 0 kB ( 0%) ggc tree CFG construction : 0.08 ( 1%) usr 0.03 ( 3%) sys 0.11 ( 1%) wall 37602 kB (10%) ggc tree CFG cleanup : 0.03 ( 0%) usr 0.02 ( 2%) sys 0.05 ( 1%) wall 0 kB ( 0%) ggc dominance computation : 0.02 ( 0%) usr 0.00 ( 0%) sys 0.02 ( 0%) wall 0 kB ( 0%) ggc expand : 1.44 (20%) usr 0.12 (11%) sys 1.56 (19%) wall 89055 kB (24%) ggc local alloc : 0.62 ( 9%) usr 0.02 ( 2%) sys 0.64 ( 8%) wall 3032 kB ( 1%) ggc global alloc : 1.31 (18%) usr 0.03 ( 3%) sys 1.34 (16%) wall 18079 kB ( 5%) ggc thread pro- & epilogue: 0.11 ( 2%) usr 0.00 ( 0%) sys 0.11 ( 1%) wall 256 kB ( 0%) ggc final : 0.49 ( 7%) usr 0.02 ( 2%) sys 0.51 ( 6%) wall 360 kB ( 0%) ggc symout : 0.10 ( 1%) usr 0.03 ( 3%) sys 0.13 ( 2%) wall 21440 kB ( 6%) ggc TOTAL : 7.14 1.12 8.26 363573 kB # cc1 7.14 1.15 # as 0.79 0.02 gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.3.o 7.93s user 1.17s system 99% cpu 9.118 total time gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.3.o -ftime-report Execution times (seconds) garbage collection : 0.10 ( 1%) usr 0.00 ( 0%) sys 0.10 ( 1%) wall 0 kB ( 0%) ggc cfg cleanup : 0.06 ( 1%) usr 0.00 ( 0%) sys 0.06 ( 1%) wall 19 kB ( 0%) ggc trivially dead code : 0.06 ( 1%) usr 0.00 ( 0%) sys 0.06 ( 1%) wall 0 kB ( 0%) ggc df live regs : 0.08 ( 1%) usr 0.00 ( 0%) sys 0.08 ( 1%) wall 0 kB ( 0%) ggc df reg dead/unused notes: 0.08 ( 1%) usr 0.00 ( 0%) sys 0.08 ( 1%) wall 6838 kB ( 2%) ggc register information : 0.09 ( 1%) usr 0.00 ( 0%) sys 0.09 ( 1%) wall 0 kB ( 0%) ggc alias analysis : 0.04 ( 1%) usr 0.00 ( 0%) sys 0.04 ( 0%) wall 2315 kB ( 1%) ggc rebuild jump labels : 0.07 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 0 kB ( 0%) ggc preprocessing : 0.46 ( 6%) usr 0.24 (22%) sys 0.66 ( 8%) wall 24801 kB ( 7%) ggc lexical analysis : 0.18 ( 2%) usr 0.38 (36%) sys 0.59 ( 7%) wall 0 kB ( 0%) ggc parser : 1.00 (14%) usr 0.26 (24%) sys 1.28 (15%) wall 100143 kB (28%) ggc inline heuristics : 0.28 ( 4%) usr 0.01 ( 1%) sys 0.29 ( 4%) wall 70 kB ( 0%) ggc tree gimplify : 0.55 ( 8%) usr 0.03 ( 3%) sys 0.58 ( 7%) wall 58497 kB (16%) ggc tree eh : 0.02 ( 0%) usr 0.01 ( 1%) sys 0.02 ( 0%) wall 0 kB ( 0%) ggc tree CFG construction : 0.08 ( 1%) usr 0.01 ( 1%) sys 0.09 ( 1%) wall 37602 kB (10%) ggc tree CFG cleanup : 0.04 ( 1%) usr 0.00 ( 0%) sys 0.04 ( 0%) wall 0 kB ( 0%) ggc dominance computation : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.03 ( 0%) wall 0 kB ( 0%) ggc expand : 1.44 (20%) usr 0.09 ( 8%) sys 1.53 (18%) wall 89055 kB (24%) ggc local alloc : 0.64 ( 9%) usr 0.00 ( 0%) sys 0.64 ( 8%) wall 3032 kB ( 1%) ggc global alloc : 1.30 (18%) usr 0.01 ( 1%) sys 1.31 (16%) wall 18079 kB ( 5%) ggc thread pro- & epilogue: 0.13 ( 2%) usr 0.00 ( 0%) sys 0.13 ( 2%) wall 256 kB ( 0%) ggc final : 0.37 ( 5%) usr 0.00 ( 0%) sys 0.37 ( 4%) wall 360 kB ( 0%) ggc symout : 0.10 ( 1%) usr 0.01 ( 1%) sys 0.11 ( 1%) wall 21440 kB ( 6%) ggc TOTAL : 7.21 1.07 8.28 363573 kB # cc1 7.21 1.10 # as 0.76 0.05 gcc-4.3 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.3.o 7.97s user 1.16s system 100% cpu 9.130 total time gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.4.o # cc1 8.59 0.26 # as 0.77 0.06 gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.4.o 9.36s user 0.32s system 99% cpu 9.685 total time gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.4.o # cc1 8.43 0.45 # as 0.79 0.05 gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.4.o 9.22s user 0.50s system 99% cpu 9.731 total time gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.4.o -ftime-report Execution times (seconds) garbage collection : 0.10 ( 1%) usr 0.00 ( 0%) sys 0.10 ( 1%) wall 0 kB ( 0%) ggc callgraph construction: 0.29 ( 3%) usr 0.02 ( 2%) sys 0.31 ( 3%) wall 13570 kB ( 3%) ggc callgraph optimization: 0.04 ( 0%) usr 0.00 ( 0%) sys 0.04 ( 0%) wall 339 kB ( 0%) ggc cfg cleanup : 0.05 ( 1%) usr 0.00 ( 0%) sys 0.05 ( 0%) wall 24 kB ( 0%) ggc trivially dead code : 0.07 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 0 kB ( 0%) ggc df live regs : 0.05 ( 1%) usr 0.01 ( 1%) sys 0.06 ( 1%) wall 0 kB ( 0%) ggc df reg dead/unused notes: 0.15 ( 2%) usr 0.00 ( 0%) sys 0.15 ( 1%) wall 6957 kB ( 2%) ggc register information : 0.07 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 0 kB ( 0%) ggc alias analysis : 0.06 ( 1%) usr 0.00 ( 0%) sys 0.06 ( 1%) wall 2405 kB ( 1%) ggc rebuild jump labels : 0.05 ( 1%) usr 0.00 ( 0%) sys 0.05 ( 0%) wall 0 kB ( 0%) ggc preprocessing : 0.56 ( 6%) usr 0.17 (16%) sys 0.75 ( 7%) wall 25440 kB ( 6%) ggc lexical analysis : 0.18 ( 2%) usr 0.40 (38%) sys 0.59 ( 6%) wall 0 kB ( 0%) ggc parser : 0.55 ( 6%) usr 0.30 (28%) sys 0.82 ( 8%) wall 72039 kB (17%) ggc inline heuristics : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.03 ( 0%) wall 0 kB ( 0%) ggc tree gimplify : 0.96 (11%) usr 0.03 ( 3%) sys 0.99 (10%) wall 88334 kB (21%) ggc tree eh : 0.01 ( 0%) usr 0.00 ( 0%) sys 0.01 ( 0%) wall 0 kB ( 0%) ggc tree CFG construction : 0.06 ( 1%) usr 0.00 ( 0%) sys 0.06 ( 1%) wall 13199 kB ( 3%) ggc tree CFG cleanup : 0.07 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 0 kB ( 0%) ggc tree find ref. vars : 0.06 ( 1%) usr 0.00 ( 0%) sys 0.06 ( 1%) wall 9130 kB ( 2%) ggc tree PHI insertion : 0.01 ( 0%) usr 0.00 ( 0%) sys 0.01 ( 0%) wall 189 kB ( 0%) ggc tree SSA rewrite : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.03 ( 0%) wall 11835 kB ( 3%) ggc tree SSA other : 0.06 ( 1%) usr 0.04 ( 4%) sys 0.10 ( 1%) wall 193 kB ( 0%) ggc tree operand scan : 0.06 ( 1%) usr 0.03 ( 3%) sys 0.09 ( 1%) wall 7012 kB ( 2%) ggc tree SSA to normal : 0.11 ( 1%) usr 0.00 ( 0%) sys 0.11 ( 1%) wall 448 kB ( 0%) ggc dominance computation : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.03 ( 0%) wall 0 kB ( 0%) ggc expand : 1.88 (21%) usr 0.01 ( 1%) sys 1.89 (19%) wall 131416 kB (31%) ggc integrated RA : 1.68 (19%) usr 0.00 ( 0%) sys 1.68 (17%) wall 3144 kB ( 1%) ggc reload : 0.99 (11%) usr 0.00 ( 0%) sys 0.99 (10%) wall 17785 kB ( 4%) ggc thread pro- & epilogue: 0.13 ( 1%) usr 0.00 ( 0%) sys 0.13 ( 1%) wall 342 kB ( 0%) ggc final : 0.43 ( 5%) usr 0.02 ( 2%) sys 0.45 ( 4%) wall 2487 kB ( 1%) ggc symout : 0.11 ( 1%) usr 0.01 ( 1%) sys 0.12 ( 1%) wall 22415 kB ( 5%) ggc TOTAL : 8.95 1.06 10.01 429887 kB # cc1 8.96 1.09 # as 0.77 0.06 gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.4.o 9.73s user 1.15s system 99% cpu 10.901 total time gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.4.o -ftime-report Execution times (seconds) garbage collection : 0.11 ( 1%) usr 0.00 ( 0%) sys 0.11 ( 1%) wall 0 kB ( 0%) ggc callgraph construction: 0.31 ( 4%) usr 0.00 ( 0%) sys 0.31 ( 3%) wall 13570 kB ( 3%) ggc callgraph optimization: 0.07 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 339 kB ( 0%) ggc cfg cleanup : 0.05 ( 1%) usr 0.00 ( 0%) sys 0.05 ( 1%) wall 24 kB ( 0%) ggc trivially dead code : 0.08 ( 1%) usr 0.00 ( 0%) sys 0.08 ( 1%) wall 0 kB ( 0%) ggc df live regs : 0.06 ( 1%) usr 0.00 ( 0%) sys 0.06 ( 1%) wall 0 kB ( 0%) ggc df reg dead/unused notes: 0.15 ( 2%) usr 0.00 ( 0%) sys 0.15 ( 2%) wall 6957 kB ( 2%) ggc register information : 0.08 ( 1%) usr 0.00 ( 0%) sys 0.08 ( 1%) wall 0 kB ( 0%) ggc alias analysis : 0.05 ( 1%) usr 0.00 ( 0%) sys 0.05 ( 1%) wall 2405 kB ( 1%) ggc rebuild jump labels : 0.07 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 0 kB ( 0%) ggc preprocessing : 0.37 ( 4%) usr 0.19 (16%) sys 0.56 ( 6%) wall 25440 kB ( 6%) ggc lexical analysis : 0.21 ( 2%) usr 0.36 (31%) sys 0.63 ( 6%) wall 0 kB ( 0%) ggc parser : 0.63 ( 7%) usr 0.33 (28%) sys 0.90 ( 9%) wall 72039 kB (17%) ggc inline heuristics : 0.07 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 0 kB ( 0%) ggc tree gimplify : 1.03 (12%) usr 0.06 ( 5%) sys 1.09 (11%) wall 88334 kB (21%) ggc tree eh : 0.02 ( 0%) usr 0.00 ( 0%) sys 0.02 ( 0%) wall 0 kB ( 0%) ggc tree CFG construction : 0.04 ( 0%) usr 0.01 ( 1%) sys 0.05 ( 1%) wall 13199 kB ( 3%) ggc tree CFG cleanup : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.03 ( 0%) wall 0 kB ( 0%) ggc tree find ref. vars : 0.03 ( 0%) usr 0.01 ( 1%) sys 0.04 ( 0%) wall 9130 kB ( 2%) ggc tree PHI insertion : 0.02 ( 0%) usr 0.00 ( 0%) sys 0.02 ( 0%) wall 189 kB ( 0%) ggc tree SSA rewrite : 0.01 ( 0%) usr 0.02 ( 2%) sys 0.03 ( 0%) wall 11835 kB ( 3%) ggc tree SSA other : 0.04 ( 0%) usr 0.04 ( 3%) sys 0.07 ( 1%) wall 193 kB ( 0%) ggc tree operand scan : 0.05 ( 1%) usr 0.04 ( 3%) sys 0.10 ( 1%) wall 7012 kB ( 2%) ggc tree SSA to normal : 0.11 ( 1%) usr 0.00 ( 0%) sys 0.11 ( 1%) wall 448 kB ( 0%) ggc dominance computation : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.03 ( 0%) wall 0 kB ( 0%) ggc expand : 1.79 (20%) usr 0.03 ( 3%) sys 1.82 (18%) wall 131416 kB (31%) ggc integrated RA : 1.60 (18%) usr 0.01 ( 1%) sys 1.61 (16%) wall 3144 kB ( 1%) ggc reload : 0.98 (11%) usr 0.04 ( 3%) sys 1.02 (10%) wall 17785 kB ( 4%) ggc thread pro- & epilogue: 0.12 ( 1%) usr 0.00 ( 0%) sys 0.12 ( 1%) wall 342 kB ( 0%) ggc final : 0.47 ( 5%) usr 0.01 ( 1%) sys 0.48 ( 5%) wall 2487 kB ( 1%) ggc symout : 0.14 ( 2%) usr 0.00 ( 0%) sys 0.14 ( 1%) wall 22415 kB ( 5%) ggc TOTAL : 8.82 1.17 9.99 429887 kB # cc1 8.83 1.20 # as 0.79 0.04 gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.4.o 9.62s user 1.24s system 99% cpu 10.861 total time gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.4.o -ftime-report Execution times (seconds) garbage collection : 0.11 ( 1%) usr 0.00 ( 0%) sys 0.11 ( 1%) wall 0 kB ( 0%) ggc callgraph construction: 0.24 ( 3%) usr 0.03 ( 3%) sys 0.27 ( 3%) wall 13570 kB ( 3%) ggc callgraph optimization: 0.07 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 339 kB ( 0%) ggc cfg cleanup : 0.06 ( 1%) usr 0.00 ( 0%) sys 0.06 ( 1%) wall 24 kB ( 0%) ggc trivially dead code : 0.09 ( 1%) usr 0.00 ( 0%) sys 0.09 ( 1%) wall 0 kB ( 0%) ggc df live regs : 0.09 ( 1%) usr 0.00 ( 0%) sys 0.09 ( 1%) wall 0 kB ( 0%) ggc df reg dead/unused notes: 0.14 ( 2%) usr 0.00 ( 0%) sys 0.14 ( 1%) wall 6957 kB ( 2%) ggc register information : 0.07 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 0 kB ( 0%) ggc alias analysis : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.03 ( 0%) wall 2405 kB ( 1%) ggc rebuild jump labels : 0.05 ( 1%) usr 0.00 ( 0%) sys 0.05 ( 0%) wall 0 kB ( 0%) ggc preprocessing : 0.49 ( 5%) usr 0.17 (16%) sys 0.74 ( 7%) wall 25440 kB ( 6%) ggc lexical analysis : 0.27 ( 3%) usr 0.43 (39%) sys 0.65 ( 6%) wall 0 kB ( 0%) ggc parser : 0.53 ( 6%) usr 0.21 (19%) sys 0.71 ( 7%) wall 72039 kB (17%) ggc inline heuristics : 0.03 ( 0%) usr 0.00 ( 0%) sys 0.03 ( 0%) wall 0 kB ( 0%) ggc tree gimplify : 1.00 (11%) usr 0.06 ( 6%) sys 1.06 (11%) wall 88334 kB (21%) ggc tree eh : 0.01 ( 0%) usr 0.00 ( 0%) sys 0.01 ( 0%) wall 0 kB ( 0%) ggc tree CFG construction : 0.06 ( 1%) usr 0.01 ( 1%) sys 0.07 ( 1%) wall 13199 kB ( 3%) ggc tree CFG cleanup : 0.08 ( 1%) usr 0.00 ( 0%) sys 0.08 ( 1%) wall 0 kB ( 0%) ggc tree find ref. vars : 0.04 ( 0%) usr 0.01 ( 1%) sys 0.05 ( 0%) wall 9130 kB ( 2%) ggc tree SSA rewrite : 0.03 ( 0%) usr 0.01 ( 1%) sys 0.04 ( 0%) wall 11835 kB ( 3%) ggc tree SSA other : 0.06 ( 1%) usr 0.00 ( 0%) sys 0.07 ( 1%) wall 193 kB ( 0%) ggc tree operand scan : 0.07 ( 1%) usr 0.03 ( 3%) sys 0.09 ( 1%) wall 7012 kB ( 2%) ggc tree SSA to normal : 0.09 ( 1%) usr 0.00 ( 0%) sys 0.09 ( 1%) wall 448 kB ( 0%) ggc dominance computation : 0.06 ( 1%) usr 0.00 ( 0%) sys 0.06 ( 1%) wall 0 kB ( 0%) ggc expand : 1.69 (19%) usr 0.06 ( 6%) sys 1.75 (17%) wall 131416 kB (31%) ggc integrated RA : 1.64 (18%) usr 0.01 ( 1%) sys 1.65 (16%) wall 3144 kB ( 1%) ggc reload : 1.01 (11%) usr 0.02 ( 2%) sys 1.03 (10%) wall 17785 kB ( 4%) ggc thread pro- & epilogue: 0.15 ( 2%) usr 0.00 ( 0%) sys 0.15 ( 1%) wall 342 kB ( 0%) ggc final : 0.55 ( 6%) usr 0.00 ( 0%) sys 0.55 ( 5%) wall 2487 kB ( 1%) ggc symout : 0.11 ( 1%) usr 0.02 ( 2%) sys 0.13 ( 1%) wall 22415 kB ( 5%) ggc TOTAL : 8.95 1.09 10.04 429887 kB # cc1 8.95 1.12 # as 0.76 0.08 gcc-4.4 -time -O0 -g -fPIC warmelt-normal-1.i -c -o warmelt-normal-4.4.o 9.71s user 1.20s system 99% cpu 10.915 total ## So I don't understand what happens to me. Perhaps I have two different brands of RAM on my desktop??? Anyway, you can retrieve the warmelt-normal-1.i file from the bug report PR41971 and try yourself. Regards. -- Basile STARYNKEVITCH http://starynkevitch.net/Basile/ email: basilestarynkevitchnet mobile: +33 6 8501 2359 8, rue de la Faiencerie, 92340 Bourg La Reine, France *** opinions {are only mines, sont seulement les miennes} ***