On Wed, Feb 24, 2010 at 10:42:03AM +0000, [email protected] wrote:
> Revision: 1081
> Author: tim.bunce
> Date: Wed Feb 24 02:40:49 2010
> Log: More refinements to shed light on freebsd test failures like
> http://www.cpantesters.org/cpan/report/6859183
I can replicate this:
t/61-cputime.t ......... 1/15 profile_this() using
/home/nick/Sandpit/snap5.9.x-v5.11.5-25-g1369b85/bin/perl5.11.5 -d:NYTProf with
NYTPROF=compress=1:file=nytprof_61-cputime.out:leave=0:savesrc=0:slowops=0:start=init:stmts=0:use_db_sub=0:usecputime=1
step 0.007812 1267019778.081813
tick 0.0156 1267019779.089130
tick 0.0234 1267019779.096045
tick 0.0312 1267019779.126041
tick 0.0391 1267019779.149034
tick 0.0469 1267019779.171532
tick 0.0547 1267019779.179032
tick 0.0625 1267019779.186528
tick 0.0703 1267019779.207653
tick 0.0781 1267019779.216006
tick 0.0859 1267019779.239670
tick 0.0938 1267019779.286145
tick 0.1016 1267019779.306978
tick 0.1094 1267019779.314583
tick 0.1172 1267019779.344982
tick 0.1250 1267019779.374968
tick 0.1328 1267019779.389498
tick 0.1406 1267019779.419481
tick 0.1484 1267019779.426981
tick 0.1562 1267019779.464476
tick 0.1641 1267019779.528847
tick 0.1719 1267019779.536337
tick 0.1797 1267019779.551335
tick 0.1875 1267019779.573828
tick 0.1953 1267019779.618319
tick 0.2031 1267019779.634397
tick 0.2109 1267019779.665564
tick 0.2188 1267019779.681779
tick 0.2266 1267019779.727913
tick 0.2344 1267019779.788394
tick 0.2422 1267019779.795997
tick 0.2500 1267019779.803487
tick 0.2578 1267019779.810985
tick 0.2656 1267019779.825976
tick 0.2734 1267019779.840989
tick 0.2812 1267019779.863472
tick 0.2891 1267019779.893467
tick 0.2969 1267019779.923460
tick 0.3047 1267019779.930960
tick 0.3125 1267019779.953970
tick 0.3203 1267019779.991881
tick 0.3281 1267019780.000489
tick 0.3359 1267019780.016582
tick 0.3438 1267019780.055186
tick 0.3516 1267019780.093840
tick 0.3594 1267019780.117432
tick 0.3672 1267019780.171111
tick 0.3750 1267019780.209327
tick 0.3828 1267019780.261805
tick 0.3906 1267019780.294876
tick 0.3984 1267019780.317689
tick 0.4062 1267019780.336896
cputime loop count 156536
t/61-cputime.t ......... 2/15
# Failed test 'cputime of foo() should be not much more than 0.4'
# at t/61-cputime.t line 38.
# '1.25'
# <
# '1'
profile_this() using
/home/nick/Sandpit/snap5.9.x-v5.11.5-25-g1369b85/bin/perl5.11.5 -d:NYTProf with
NYTPROF=compress=1:file=nytprof_61-cputime.out:leave=0:savesrc=0:slowops=0:start=init:stmts=0:use_db_sub=1:usecputime=1
step 0.007812 1267019781.535973
tick 0.0156 1267019782.543293
tick 0.0234 1267019782.558280
tick 0.0312 1267019782.565783
tick 0.0391 1267019782.588273
tick 0.0469 1267019782.629409
tick 0.0547 1267019782.636893
tick 0.0625 1267019782.659390
tick 0.0703 1267019782.715759
tick 0.0781 1267019782.731250
tick 0.0859 1267019782.738749
tick 0.0938 1267019782.768743
tick 0.1016 1267019782.795339
tick 0.1094 1267019782.802835
tick 0.1172 1267019782.825333
tick 0.1250 1267019782.885457
tick 0.1328 1267019782.932009
tick 0.1406 1267019782.947964
tick 0.1484 1267019782.994384
tick 0.1562 1267019783.010208
tick 0.1641 1267019783.018370
tick 0.1719 1267019783.034181
tick 0.1797 1267019783.042297
tick 0.1875 1267019783.103284
tick 0.1953 1267019783.125312
tick 0.2031 1267019783.132801
tick 0.2109 1267019783.148304
tick 0.2188 1267019783.163296
tick 0.2266 1267019783.178296
tick 0.2344 1267019783.185791
tick 0.2422 1267019783.197170
tick 0.2500 1267019783.231260
tick 0.2578 1267019783.238756
tick 0.2656 1267019783.325138
tick 0.2734 1267019783.347636
tick 0.2812 1267019783.370129
tick 0.2891 1267019783.392628
tick 0.2969 1267019783.400127
tick 0.3047 1267019783.426257
tick 0.3125 1267019783.433744
tick 0.3203 1267019783.456415
tick 0.3281 1267019783.471237
tick 0.3359 1267019783.486918
tick 0.3438 1267019783.533307
tick 0.3516 1267019783.541540
tick 0.3594 1267019783.572648
tick 0.3672 1267019783.611429
tick 0.3750 1267019783.673097
tick 0.3828 1267019783.681326
tick 0.3906 1267019783.697183
tick 0.3984 1267019783.743597
tick 0.4062 1267019783.767093
cputime loop count 146877
t/61-cputime.t ......... 9/15
# Failed test 'cputime of foo() should be not much more than 0.4'
# at t/61-cputime.t line 38.
# '1.2265625'
# <
# '1'
# Looks like you failed 2 tests of 15.
t/61-cputime.t ......... Dubious, test returned 2 (wstat 512, 0x200)
Failed 2/15 subtests
t/80-version.t ......... ok
This is:
Summary of my perl5 (revision 5 version 11 subversion 5) configuration:
Commit id: 1369b85fd244c3fb26c30101219e97eb0ea12f24
Platform:
osname=freebsd, osvers=7.0-stable, archname=i386-freebsd
uname='freebsd plum.flirble.org 7.0-stable freebsd 7.0-stable #7: sat jul
26 20:39:26 bst 2008 [email protected]:usrobjusrsrcsysplum i386 '
config_args='-Dusedevel=y -Dcc=ccache gcc -Dld=gcc -Ubincompat5005
-Uinstallusrbinperl [email protected] [email protected]
-Dinc_version_list= -Dinc_version_list_init=0 -Doptimize=-O2 -Uusethreads
-Uuse64bitint -Accflags=-DNO_MATHOMS -Uusemymalloc -Duseperlio
-Dprefix=~/Sandpit/snap5.9.x-v5.11.5-25-g1369b85 -Dinstallman1dir=none
-Dinstallman3dir=none -Uuserelocatableinc -de'
hint=recommended, useposix=true, d_sigaction=define
useithreads=undef, usemultiplicity=undef
useperlio=define, d_sfio=undef, uselargefiles=define, usesocks=undef
use64bitint=undef, use64bitall=undef, uselongdouble=undef
usemymalloc=n, bincompat5005=undef
Compiler:
cc='ccache gcc', ccflags ='-DHAS_FPSETMASK -DHAS_FLOATINGPOINT_H
-DNO_MATHOMS -fno-strict-aliasing -pipe -fstack-protector -I/usr/local/include',
optimize='-O2',
cppflags='-DHAS_FPSETMASK -DHAS_FLOATINGPOINT_H -DNO_MATHOMS
-fno-strict-aliasing -pipe -fstack-protector -I/usr/local/include'
ccversion='', gccversion='4.2.1 20070719 [FreeBSD]', gccosandvers=''
intsize=4, longsize=4, ptrsize=4, doublesize=8, byteorder=1234
d_longlong=define, longlongsize=8, d_longdbl=define, longdblsize=12
ivtype='long', ivsize=4, nvtype='double', nvsize=8, Off_t='off_t',
lseeksize=8
alignbytes=4, prototype=define
Linker and Libraries:
ld='gcc', ldflags ='-Wl,-E -fstack-protector -L/usr/local/lib'
libpth=/usr/lib /usr/local/lib
libs=-lm -lcrypt -lutil -lc
perllibs=-lm -lcrypt -lutil -lc
libc=, so=so, useshrplib=false, libperl=libperl.a
gnulibc_version=''
Dynamic Linking:
dlsrc=dl_dlopen.xs, dlext=so, d_dlsymun=undef, ccdlflags=' '
cccdlflags='-DPIC -fPIC', lddlflags='-shared -L/usr/local/lib
-fstack-protector'
Characteristics of this binary (from libperl):
Compile-time options: NO_MATHOMS PERL_DONT_CREATE_GVSV PERL_MALLOC_WRAP
PERL_USE_DEVEL USE_LARGE_FILES USE_PERLIO
USE_PERL_ATOF
Built under freebsd
Compiled at Feb 24 2010 11:05:26
@INC:
/home/nick/Sandpit/snap5.9.x-v5.11.5-25-g1369b85/lib/perl5/site_perl/5.11.5/i386-freebsd
/home/nick/Sandpit/snap5.9.x-v5.11.5-25-g1369b85/lib/perl5/site_perl/5.11.5
/home/nick/Sandpit/snap5.9.x-v5.11.5-25-g1369b85/lib/perl5/5.11.5/i386-freebsd
/home/nick/Sandpit/snap5.9.x-v5.11.5-25-g1369b85/lib/perl5/5.11.5
.
I have no idea what to do next.
Nicholas Clark
--
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]
