Revision: 845 Author: tim.bunce Date: Sat Jul 25 18:02:45 2009 Log: Resync tests to include print and unlink slowops.
http://code.google.com/p/perl-devel-nytprof/source/detail?r=845 Modified: /trunk/t/test01.rdt /trunk/t/test02.rdt /trunk/t/test03.rdt /trunk/t/test05.rdt /trunk/t/test06.rdt /trunk/t/test07.rdt /trunk/t/test13.rdt /trunk/t/test20-streval.rdt /trunk/t/test22-strevala.rdt /trunk/t/test30-fork-0.rdt /trunk/t/test51-enable.rdt /trunk/t/test51-enable.t /trunk/t/test61-submerge.rdt ======================================= --- /trunk/t/test01.rdt Mon Jul 20 11:56:41 2009 +++ /trunk/t/test01.rdt Sat Jul 25 18:02:45 2009 @@ -20,10 +20,14 @@ fid_block_time 1 18 [ 0 1 ] fid_fileinfo 1 [ test01.p 1 2 0 0 ] fid_fileinfo 1 sub main::BEGIN 0-0 +fid_fileinfo 1 sub main::CORE:print 0-0 fid_fileinfo 1 sub main::bar 6-8 fid_fileinfo 1 sub main::baz 10-14 fid_fileinfo 1 sub main::foo 1-4 +fid_fileinfo 1 call 2 main::CORE:print [ 2 0 0 0 0 0 0 main::foo ] fid_fileinfo 1 call 3 main::bar [ 2 0 0 0 0 0 0 main::foo ] +fid_fileinfo 1 call 7 main::CORE:print [ 4 0 0 0 0 0 0 main::bar ] +fid_fileinfo 1 call 11 main::CORE:print [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 12 main::bar [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 13 main::foo [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 16 main::bar [ 1 0 0 0 0 0 0 main::RUNTIME ] @@ -48,6 +52,10 @@ profile_modes fid_line_time line profile_modes fid_sub_time sub sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:print [ 1 0 0 7 0 0 0 0 ] +sub_subinfo main::CORE:print called_by 1 2 [ 2 0 0 0 0 0 0 main::foo ] +sub_subinfo main::CORE:print called_by 1 7 [ 4 0 0 0 0 0 0 main::bar ] +sub_subinfo main::CORE:print called_by 1 11 [ 1 0 0 0 0 0 0 main::baz ] sub_subinfo main::bar [ 1 6 8 4 0 0 0 0 ] sub_subinfo main::bar called_by 1 3 [ 2 0 0 0 0 0 0 main::foo ] sub_subinfo main::bar called_by 1 12 [ 1 0 0 0 0 0 0 main::baz ] ======================================= --- /trunk/t/test02.rdt Mon Jul 20 11:56:41 2009 +++ /trunk/t/test02.rdt Sat Jul 25 18:02:45 2009 @@ -21,10 +21,14 @@ fid_block_time 1 21 [ 0 1 ] fid_fileinfo 1 [ test02.p 1 2 0 0 ] fid_fileinfo 1 sub main::BEGIN 0-0 +fid_fileinfo 1 sub main::CORE:print 0-0 fid_fileinfo 1 sub main::bar 6-8 fid_fileinfo 1 sub main::baz 10-16 fid_fileinfo 1 sub main::foo 1-4 +fid_fileinfo 1 call 2 main::CORE:print [ 2 0 0 0 0 0 0 main::foo ] fid_fileinfo 1 call 3 main::bar [ 2 0 0 0 0 0 0 main::foo ] +fid_fileinfo 1 call 7 main::CORE:print [ 7 0 0 0 0 0 0 main::bar ] +fid_fileinfo 1 call 11 main::CORE:print [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 12 main::bar [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 13 main::bar [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 14 main::bar [ 1 0 0 0 0 0 0 main::baz ] @@ -56,6 +60,10 @@ profile_modes fid_line_time line profile_modes fid_sub_time sub sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:print [ 1 0 0 10 0 0 0 0 ] +sub_subinfo main::CORE:print called_by 1 2 [ 2 0 0 0 0 0 0 main::foo ] +sub_subinfo main::CORE:print called_by 1 7 [ 7 0 0 0 0 0 0 main::bar ] +sub_subinfo main::CORE:print called_by 1 11 [ 1 0 0 0 0 0 0 main::baz ] sub_subinfo main::bar [ 1 6 8 7 0 0 0 0 ] sub_subinfo main::bar called_by 1 3 [ 2 0 0 0 0 0 0 main::foo ] sub_subinfo main::bar called_by 1 12 [ 1 0 0 0 0 0 0 main::baz ] ======================================= --- /trunk/t/test03.rdt Mon Jul 20 11:56:41 2009 +++ /trunk/t/test03.rdt Sat Jul 25 18:02:45 2009 @@ -19,9 +19,13 @@ fid_block_time 1 18 [ 0 1 ] fid_fileinfo 1 [ test03.p 1 2 0 0 ] fid_fileinfo 1 sub main::BEGIN 0-0 +fid_fileinfo 1 sub main::CORE:print 0-0 fid_fileinfo 1 sub main::bar 7-9 fid_fileinfo 1 sub main::baz 11-15 fid_fileinfo 1 sub main::foo 1-5 +fid_fileinfo 1 call 2 main::CORE:print [ 1 0 0 0 0 0 0 main::foo ] +fid_fileinfo 1 call 8 main::CORE:print [ 2 0 0 0 0 0 0 main::bar ] +fid_fileinfo 1 call 12 main::CORE:print [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 13 main::bar [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 14 main::foo [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 17 main::bar [ 1 0 0 0 0 0 0 main::RUNTIME ] @@ -43,6 +47,10 @@ profile_modes fid_line_time line profile_modes fid_sub_time sub sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:print [ 1 0 0 4 0 0 0 0 ] +sub_subinfo main::CORE:print called_by 1 2 [ 1 0 0 0 0 0 0 main::foo ] +sub_subinfo main::CORE:print called_by 1 8 [ 2 0 0 0 0 0 0 main::bar ] +sub_subinfo main::CORE:print called_by 1 12 [ 1 0 0 0 0 0 0 main::baz ] sub_subinfo main::bar [ 1 7 9 2 0 0 0 0 ] sub_subinfo main::bar called_by 1 13 [ 1 0 0 0 0 0 0 main::baz ] sub_subinfo main::bar called_by 1 17 [ 1 0 0 0 0 0 0 main::RUNTIME ] ======================================= --- /trunk/t/test05.rdt Mon Jul 20 11:56:41 2009 +++ /trunk/t/test05.rdt Sat Jul 25 18:02:45 2009 @@ -20,13 +20,18 @@ fid_block_time 1 23 [ 0 1 ] fid_fileinfo 1 [ test05.p 1 2 0 0 ] fid_fileinfo 1 sub main::BEGIN 0-0 +fid_fileinfo 1 sub main::CORE:print 0-0 fid_fileinfo 1 sub main::bar 12-17 fid_fileinfo 1 sub main::foo1 4-7 fid_fileinfo 1 sub main::foo2 8-11 fid_fileinfo 1 sub main::yeppers 18-20 +fid_fileinfo 1 call 5 main::CORE:print [ 1 0 0 0 0 0 0 main::foo1 ] fid_fileinfo 1 call 6 main::bar [ 1 0 0 0 0 0 0 main::foo1 ] +fid_fileinfo 1 call 9 main::CORE:print [ 1 0 0 0 0 0 0 main::foo2 ] fid_fileinfo 1 call 10 main::bar [ 1 0 0 0 0 0 0 main::foo2 ] +fid_fileinfo 1 call 13 main::CORE:print [ 2 0 0 0 0 0 0 main::bar ] fid_fileinfo 1 call 14 main::yeppers [ 2 0 0 0 0 0 0 main::bar ] +fid_fileinfo 1 call 19 main::CORE:print [ 2 0 0 0 0 0 0 main::yeppers ] fid_fileinfo 1 call 22 main::foo1 [ 1 0 0 0 0 0 0 main::RUNTIME ] fid_fileinfo 1 call 23 main::foo2 [ 1 0 0 0 0 0 0 main::RUNTIME ] fid_line_time 1 5 [ 0 1 ] @@ -48,6 +53,11 @@ profile_modes fid_line_time line profile_modes fid_sub_time sub sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:print [ 1 0 0 6 0 0 0 0 ] +sub_subinfo main::CORE:print called_by 1 5 [ 1 0 0 0 0 0 0 main::foo1 ] +sub_subinfo main::CORE:print called_by 1 9 [ 1 0 0 0 0 0 0 main::foo2 ] +sub_subinfo main::CORE:print called_by 1 13 [ 2 0 0 0 0 0 0 main::bar ] +sub_subinfo main::CORE:print called_by 1 19 [ 2 0 0 0 0 0 0 main::yeppers ] sub_subinfo main::bar [ 1 12 17 2 0 0 0 0 ] sub_subinfo main::bar called_by 1 6 [ 1 0 0 0 0 0 0 main::foo1 ] sub_subinfo main::bar called_by 1 10 [ 1 0 0 0 0 0 0 main::foo2 ] ======================================= --- /trunk/t/test06.rdt Mon Jul 20 11:56:41 2009 +++ /trunk/t/test06.rdt Sat Jul 25 18:02:45 2009 @@ -28,13 +28,17 @@ fid_block_time 1 44 [ 0 1 ] fid_fileinfo 1 [ test06.p 1 2 0 0 ] fid_fileinfo 1 sub main::BEGIN 0-0 +fid_fileinfo 1 sub main::CORE:print 0-0 fid_fileinfo 1 sub main::bar 19-28 fid_fileinfo 1 sub main::baz 30-40 fid_fileinfo 1 sub main::foo 9-17 fid_fileinfo 1 sub main::noop 5-7 +fid_fileinfo 1 call 10 main::CORE:print [ 1 0 0 0 0 0 0 main::foo ] fid_fileinfo 1 call 12 main::noop [ 10 0 0 0 0 0 0 main::foo ] fid_fileinfo 1 call 14 main::noop [ 100 0 0 0 0 0 0 main::foo ] +fid_fileinfo 1 call 20 main::CORE:print [ 1 0 0 0 0 0 0 main::bar ] fid_fileinfo 1 call 25 main::noop [ 100 0 0 0 0 0 0 main::bar ] +fid_fileinfo 1 call 31 main::CORE:print [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 36 main::noop [ 100 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 37 main::noop [ 100 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 42 main::foo [ 1 0 0 0 0 0 0 main::RUNTIME ] @@ -75,6 +79,10 @@ profile_modes fid_line_time line profile_modes fid_sub_time sub sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:print [ 1 0 0 3 0 0 0 0 ] +sub_subinfo main::CORE:print called_by 1 10 [ 1 0 0 0 0 0 0 main::foo ] +sub_subinfo main::CORE:print called_by 1 20 [ 1 0 0 0 0 0 0 main::bar ] +sub_subinfo main::CORE:print called_by 1 31 [ 1 0 0 0 0 0 0 main::baz ] sub_subinfo main::bar [ 1 19 28 1 0 0 0 0 ] sub_subinfo main::bar called_by 1 43 [ 1 0 0 0 0 0 0 main::RUNTIME ] sub_subinfo main::baz [ 1 30 40 1 0 0 0 0 ] ======================================= --- /trunk/t/test07.rdt Fri Jul 10 16:29:35 2009 +++ /trunk/t/test07.rdt Sat Jul 25 18:02:45 2009 @@ -15,9 +15,13 @@ fid_block_time 1 1 [ 0 1 ] fid_fileinfo 1 [ test07.p 1 2 0 0 ] fid_fileinfo 1 sub main::BEGIN 0-0 +fid_fileinfo 1 sub main::CORE:print 0-0 +fid_fileinfo 1 call 1 main::CORE:print [ 1 0 0 0 0 0 0 main::RUNTIME ] fid_line_time 1 1 [ 0 1 ] fid_sub_time 1 1 [ 0 1 ] profile_modes fid_block_time block profile_modes fid_line_time line profile_modes fid_sub_time sub sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:print [ 1 0 0 1 0 0 0 0 ] +sub_subinfo main::CORE:print called_by 1 1 [ 1 0 0 0 0 0 0 main::RUNTIME ] ======================================= --- /trunk/t/test13.rdt Mon Jul 20 11:56:41 2009 +++ /trunk/t/test13.rdt Sat Jul 25 18:02:45 2009 @@ -24,9 +24,13 @@ fid_block_time 1 21 [ 0 1 ] fid_fileinfo 1 [ test13.p 1 2 0 0 ] fid_fileinfo 1 sub main::BEGIN 0-0 +fid_fileinfo 1 sub main::CORE:print 0-0 fid_fileinfo 1 sub main::bar 7-9 fid_fileinfo 1 sub main::baz 11-17 fid_fileinfo 1 sub main::foo 3-5 +fid_fileinfo 1 call 4 main::CORE:print [ 3 0 0 0 0 0 0 main::foo ] +fid_fileinfo 1 call 8 main::CORE:print [ 1 0 0 0 0 0 0 main::bar ] +fid_fileinfo 1 call 12 main::CORE:print [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 13 main::foo [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 14 main::foo [ 1 0 0 0 0 0 0 main::baz ] fid_fileinfo 1 call 20 main::bar [ 1 0 0 0 0 0 0 main::RUNTIME ] @@ -57,6 +61,10 @@ profile_modes fid_line_time line profile_modes fid_sub_time sub sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:print [ 1 0 0 5 0 0 0 0 ] +sub_subinfo main::CORE:print called_by 1 4 [ 3 0 0 0 0 0 0 main::foo ] +sub_subinfo main::CORE:print called_by 1 8 [ 1 0 0 0 0 0 0 main::bar ] +sub_subinfo main::CORE:print called_by 1 12 [ 1 0 0 0 0 0 0 main::baz ] sub_subinfo main::bar [ 1 7 9 1 0 0 0 0 ] sub_subinfo main::bar called_by 1 20 [ 1 0 0 0 0 0 0 main::RUNTIME ] sub_subinfo main::baz [ 1 11 17 1 0 0 0 0 ] ======================================= --- /trunk/t/test20-streval.rdt Mon Jul 20 11:56:41 2009 +++ /trunk/t/test20-streval.rdt Sat Jul 25 18:02:45 2009 @@ -25,7 +25,9 @@ fid_block_time 1 14 2 1 [ 0 2 ] fid_fileinfo 1 [ test20-streval.p 1 2 0 0 ] fid_fileinfo 1 sub main::BEGIN 0-0 +fid_fileinfo 1 sub main::CORE:print 0-0 fid_fileinfo 1 sub main::foo 3-3 +fid_fileinfo 1 call 3 main::CORE:print [ 4 0 0 0 0 0 0 main::foo ] fid_fileinfo 1 eval 8 [ 1 0 ] fid_fileinfo 1 eval 11 [ 2 0 ] fid_fileinfo 1 eval 14 [ 1 1 ] @@ -65,6 +67,8 @@ profile_modes fid_line_time line profile_modes fid_sub_time sub sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:print [ 1 0 0 4 0 0 0 0 ] +sub_subinfo main::CORE:print called_by 1 3 [ 4 0 0 0 0 0 0 main::foo ] sub_subinfo main::foo [ 1 3 3 4 0 0 0 0 ] sub_subinfo main::foo called_by 2 1 [ 1 0 0 0 0 0 0 main::RUNTIME ] sub_subinfo main::foo called_by 3 1 [ 1 0 0 0 0 0 0 main::RUNTIME ] ======================================= --- /trunk/t/test22-strevala.rdt Mon Jul 20 11:56:41 2009 +++ /trunk/t/test22-strevala.rdt Sat Jul 25 18:02:45 2009 @@ -33,18 +33,24 @@ fid_fileinfo 1 eval 9 [ 2 0 ] fid_fileinfo 1 eval 12 [ 1 2 ] fid_fileinfo 2 [ (eval 0)[test22-strevala.p:6] 1 6 2 2 0 0 ] +fid_fileinfo 2 sub main::CORE:print 0-0 fid_fileinfo 2 sub main::__ANON__[(eval 0)[test22-strevala.p:6]:1] 1-1 +fid_fileinfo 2 call 1 main::CORE:print [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[test22-strevala.p:6]:1] ] fid_fileinfo 3 [ (eval 0)[test22-strevala.p:9] 1 9 3 2 0 0 ] fid_fileinfo 3 sub main::__ANON__[(eval 0)[test22-strevala.p:9]:1] 1-1 +fid_fileinfo 3 call 1 main::CORE:print [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[test22-strevala.p:9]:1] ] fid_fileinfo 4 [ (eval 0)[test22-strevala.p:9] 1 9 4 2 0 0 ] fid_fileinfo 4 sub main::__ANON__[(eval 0)[test22-strevala.p:9]:1] 1-1 +fid_fileinfo 4 call 1 main::CORE:print [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[test22-strevala.p:9]:1] ] fid_fileinfo 5 [ (eval 0)[test22-strevala.p:12] 1 12 5 2 0 0 ] fid_fileinfo 5 call 2 main::__ANON__[(eval 0)[(eval 0)[test22-strevala.p:12]:2]:1] [ 2 0 0 0 0 0 0 main::RUNTIME ] fid_fileinfo 5 eval 2 [ 2 0 ] fid_fileinfo 6 [ (eval 0)[(eval 0)[test22-strevala.p:12]:2] 5 2 6 2 0 0 ] fid_fileinfo 6 sub main::__ANON__[(eval 0)[(eval 0)[test22-strevala.p:12]:2]:1] 1-1 +fid_fileinfo 6 call 1 main::CORE:print [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[(eval 0)[test22-strevala.p:12]:2]:1] ] fid_fileinfo 7 [ (eval 0)[(eval 0)[test22-strevala.p:12]:2] 5 2 7 2 0 0 ] fid_fileinfo 7 sub main::__ANON__[(eval 0)[(eval 0)[test22-strevala.p:12]:2]:1] 1-1 +fid_fileinfo 7 call 1 main::CORE:print [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[(eval 0)[test22-strevala.p:12]:2]:1] ] fid_line_time 1 3 [ 0 1 ] fid_line_time 1 6 0 0 fid_line_time 1 6 1 1 @@ -75,6 +81,12 @@ profile_modes fid_line_time line profile_modes fid_sub_time sub sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:print [ 2 0 0 5 0 0 0 0 ] +sub_subinfo main::CORE:print called_by 2 1 [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[test22-strevala.p:6]:1] ] +sub_subinfo main::CORE:print called_by 3 1 [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[test22-strevala.p:9]:1] ] +sub_subinfo main::CORE:print called_by 4 1 [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[test22-strevala.p:9]:1] ] +sub_subinfo main::CORE:print called_by 6 1 [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[(eval 0)[test22-strevala.p:12]:2]:1] ] +sub_subinfo main::CORE:print called_by 7 1 [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[(eval 0)[test22-strevala.p:12]:2]:1] ] sub_subinfo main::__ANON__[(eval 0)[(eval 0)[test22-strevala.p:12]:2]:1] [ 6 1 1 2 0 0 0 0 ] sub_subinfo main::__ANON__[(eval 0)[(eval 0)[test22-strevala.p:12]:2]:1] called_by 5 2 [ 2 0 0 0 0 0 0 main::RUNTIME ] sub_subinfo main::__ANON__[(eval 0)[test22-strevala.p:6]:1] [ 2 1 1 1 0 0 0 0 ] ======================================= --- /trunk/t/test30-fork-0.rdt Mon Jul 20 11:56:41 2009 +++ /trunk/t/test30-fork-0.rdt Sat Jul 25 18:02:45 2009 @@ -22,11 +22,15 @@ fid_block_time 1 22 [ 0 1 ] fid_fileinfo 1 [ test30-fork-0.p 1 2 0 0 ] fid_fileinfo 1 sub main::BEGIN 0-0 +fid_fileinfo 1 sub main::CORE:print 0-0 fid_fileinfo 1 sub main::CORE:wait 0-0 fid_fileinfo 1 sub main::other 6-8 fid_fileinfo 1 sub main::postfork 10-13 fid_fileinfo 1 sub main::prefork 1-4 +fid_fileinfo 1 call 2 main::CORE:print [ 1 0 0 0 0 0 0 main::prefork ] fid_fileinfo 1 call 3 main::other [ 1 0 0 0 0 0 0 main::prefork ] +fid_fileinfo 1 call 7 main::CORE:print [ 3 0 0 0 0 0 0 main::other ] +fid_fileinfo 1 call 11 main::CORE:print [ 1 0 0 0 0 0 0 main::postfork ] fid_fileinfo 1 call 12 main::other [ 1 0 0 0 0 0 0 main::postfork ] fid_fileinfo 1 call 15 main::prefork [ 1 0 0 0 0 0 0 main::RUNTIME ] fid_fileinfo 1 call 19 main::postfork [ 1 0 0 0 0 0 0 main::RUNTIME ] @@ -54,6 +58,10 @@ profile_modes fid_line_time line profile_modes fid_sub_time sub sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:print [ 1 0 0 5 0 0 0 0 ] +sub_subinfo main::CORE:print called_by 1 2 [ 1 0 0 0 0 0 0 main::prefork ] +sub_subinfo main::CORE:print called_by 1 7 [ 3 0 0 0 0 0 0 main::other ] +sub_subinfo main::CORE:print called_by 1 11 [ 1 0 0 0 0 0 0 main::postfork ] sub_subinfo main::CORE:wait [ 1 0 0 1 0 0 0 0 ] sub_subinfo main::CORE:wait called_by 1 22 [ 1 0 0 0 0 0 0 main::RUNTIME ] sub_subinfo main::other [ 1 6 8 3 0 0 0 0 ] ======================================= --- /trunk/t/test51-enable.rdt Mon Jul 20 11:56:41 2009 +++ /trunk/t/test51-enable.rdt Sat Jul 25 18:02:45 2009 @@ -21,12 +21,14 @@ fid_block_time 1 9 [ 0 1 ] fid_fileinfo 1 [ test51-enable.p 1 2 0 0 ] fid_fileinfo 1 sub main::BEGIN 0-0 +fid_fileinfo 1 call 5 main::CORE:unlink [ 1 0 0 0 0 0 0 main::RUNTIME ] fid_fileinfo 1 call 9 main::sub1 [ 1 0 0 0 0 0 0 main::RUNTIME ] fid_fileinfo 1 call 11 DB::disable_profile [ 1 0 0 0 0 0 0 main::RUNTIME ] fid_fileinfo 1 eval 7 [ 2 0 ] fid_fileinfo 2 [ (eval 0)[test51-enable.p:7] 1 7 2 2 0 0 ] fid_fileinfo 2 sub main::sub1 1-1 fid_fileinfo 3 [ (eval 0)[test51-enable.p:7] 1 7 3 4 0 0 ] +fid_fileinfo 3 sub main::CORE:unlink 0-0 fid_fileinfo 3 sub main::sub9 1-1 fid_line_time 1 3 [ 0 1 ] fid_line_time 1 4 [ 0 1 ] @@ -48,6 +50,8 @@ sub_subinfo DB::disable_profile [ undef 0 0 1 0 0 0 0 ] sub_subinfo DB::disable_profile called_by 1 11 [ 1 0 0 0 0 0 0 main::RUNTIME ] sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:unlink [ 3 0 0 1 0 0 0 0 ] +sub_subinfo main::CORE:unlink called_by 1 5 [ 1 0 0 0 0 0 0 main::RUNTIME ] sub_subinfo main::sub1 [ 2 1 1 1 0 0 0 0 ] sub_subinfo main::sub1 called_by 1 9 [ 1 0 0 0 0 0 0 main::RUNTIME ] sub_subinfo main::sub9 [ 3 1 1 0 0 0 0 0 ] ======================================= --- /trunk/t/test51-enable.t Tue Jun 2 16:28:32 2009 +++ /trunk/t/test51-enable.t Sat Jul 25 18:02:45 2009 @@ -11,6 +11,7 @@ is_deeply(sub_calls($profile), { 'main::sub1' => 1, 'DB::disable_profile' => 1, + 'main::CORE:unlink' => 1, }); my $file_b = "nytprof-test51-b.out"; @@ -21,6 +22,7 @@ 'main::sub1' => 1, 'main::sub3' => 1, 'DB::disable_profile' => 1, + 'main::CORE:unlink' => 1, }, "$file_b sub calls"); my $pc = Devel::NYTProf::Data->new( { filename => $file_c, quiet => 0 } ); ======================================= --- /trunk/t/test61-submerge.rdt Mon Jul 20 11:56:41 2009 +++ /trunk/t/test61-submerge.rdt Sat Jul 25 18:02:45 2009 @@ -21,12 +21,14 @@ fid_fileinfo 1 [ test61-submerge.p 1 2 0 0 ] fid_fileinfo 1 sub main::BEGIN 0-0 fid_fileinfo 1 sub main::foo 4-4 +fid_fileinfo 1 call 4 main::CORE:print [ 3 0 0 0 0 0 0 main::foo ] fid_fileinfo 1 call 8 main::__ANON__[(eval 0)[test61-submerge.p:8]:1] [ 3 0 0 0 0 0 0 main::RUNTIME ] fid_fileinfo 1 eval 8 [ 3 0 ] fid_fileinfo 2 [ (eval 0)[test61-submerge.p:8] 1 8 2 2 0 0 ] fid_fileinfo 2 sub main::__ANON__[(eval 0)[test61-submerge.p:8]:1] 1-1 fid_fileinfo 2 call 1 main::foo [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[test61-submerge.p:8]:1] ] fid_fileinfo 3 [ (eval 0)[test61-submerge.p:8] 1 8 3 2 0 0 ] +fid_fileinfo 3 sub main::CORE:print 0-0 fid_fileinfo 3 sub main::__ANON__[(eval 0)[test61-submerge.p:8]:1] 1-1 fid_fileinfo 3 call 1 main::foo [ 1 0 0 0 0 0 0 main::__ANON__[(eval 0)[test61-submerge.p:8]:1] ] fid_fileinfo 4 [ (eval 0)[test61-submerge.p:8] 1 8 4 2 0 0 ] @@ -48,6 +50,8 @@ profile_modes fid_line_time line profile_modes fid_sub_time sub sub_subinfo main::BEGIN [ 1 0 0 0 0 0 0 0 ] +sub_subinfo main::CORE:print [ 3 0 0 3 0 0 0 0 ] +sub_subinfo main::CORE:print called_by 1 4 [ 3 0 0 0 0 0 0 main::foo ] sub_subinfo main::__ANON__[(eval 0)[test61-submerge.p:8]:1] [ 2 1 1 3 0 0 0 0 ] sub_subinfo main::__ANON__[(eval 0)[test61-submerge.p:8]:1] called_by 1 8 [ 3 0 0 0 0 0 0 main::RUNTIME ] sub_subinfo main::foo [ 1 4 4 3 0 0 0 0 ] --~--~---------~--~----~------------~-------~--~----~ You've received this message because you are subscribed to the Devel::NYTProf Development User group. Group hosted at: http://groups.google.com/group/develnytprof-dev Project hosted at: http://perl-devel-nytprof.googlecode.com CPAN distribution: http://search.cpan.org/dist/Devel-NYTProf To post, email: [email protected] To unsubscribe, email: [email protected] -~----------~----~----~----~------~----~------~--~---
