PATH=/usr/bin:/bin Start 2011-06-10T16:07:20 ActivePerl-818 CPAN-1.9402 Going to read '/home/fly818/var/cpan/Metadata' Database was generated on Fri, 10 Jun 2011 18:29:59 GMT Running make for Z/ZE/ZEFRAM/Time-HiRes-1.9724.tar.gz Checksum for /net/nas/data/cpan/authors/id/Z/ZE/ZEFRAM/Time-HiRes-1.9724.tar.gz ok Will not use Archive::Tar, need 1.00 Time-HiRes-1.9724/ Time-HiRes-1.9724/META.yml Time-HiRes-1.9724/MANIFEST Time-HiRes-1.9724/HiRes.pm Time-HiRes-1.9724/Changes Time-HiRes-1.9724/ppport.h Time-HiRes-1.9724/README Time-HiRes-1.9724/hints/ Time-HiRes-1.9724/hints/aix.pl Time-HiRes-1.9724/hints/dynixptx.pl Time-HiRes-1.9724/hints/solaris.pl Time-HiRes-1.9724/hints/linux.pl Time-HiRes-1.9724/hints/irix.pl Time-HiRes-1.9724/hints/dec_osf.pl Time-HiRes-1.9724/hints/svr4.pl Time-HiRes-1.9724/hints/sco.pl Time-HiRes-1.9724/TODO Time-HiRes-1.9724/HiRes.xs Time-HiRes-1.9724/fallback/ Time-HiRes-1.9724/fallback/const-c.inc Time-HiRes-1.9724/fallback/const-xs.inc Time-HiRes-1.9724/typemap Time-HiRes-1.9724/Makefile.PL Time-HiRes-1.9724/t/ Time-HiRes-1.9724/t/Watchdog.pm Time-HiRes-1.9724/t/sleep.t Time-HiRes-1.9724/t/nanosleep.t Time-HiRes-1.9724/t/itimer.t Time-HiRes-1.9724/t/usleep.t Time-HiRes-1.9724/t/ualarm.t Time-HiRes-1.9724/t/clock.t Time-HiRes-1.9724/t/gettimeofday.t Time-HiRes-1.9724/t/time.t Time-HiRes-1.9724/t/tv_interval.t Time-HiRes-1.9724/t/stat.t Time-HiRes-1.9724/t/alarm.t CPAN.pm: Going to build Z/ZE/ZEFRAM/Time-HiRes-1.9724.tar.gz >>> /home/fly818/ap818/bin/perl-static Makefile.PL Configuring Time::HiRes... Using hints hints/linux.pl... Extra libraries: -lrt... Have syscall()... looking for syscall.h... found . Looking for gettimeofday()... found. Looking for setitimer()... found. Looking for getitimer()... found. You have interval timers (both setitimer and getitimer). Looking for ualarm()... found. Looking for usleep()... found. Looking for nanosleep()... testing... found. You can mix subsecond sleeps with signals, if you want to. (It's still not portable, though.) Looking for clock_gettime()... found. Looking for clock_getres()... found. Looking for clock_nanosleep()... NOT found. Looking for clock()... found. Looking for stat() subsecond timestamps... Trying struct stat st_atimespec.tv_nsec...NOT found. Trying struct stat st_atimensec...NOT found. Trying struct stat st_atime_n...NOT found. Trying struct stat st_atim.tv_nsec...found. Trying struct stat st_uatime...Processing hints file hints/linux.pl NOT found. You seem to have stat() subsecond timestamps. (Your struct stat has them, but the filesystems must help.) Checking if your kit is complete... Looks good Writing Makefile for Time::HiRes Now you may issue 'make'. Do not forget also 'make test'. >>> make cp HiRes.pm blib/lib/Time/HiRes.pm /home/fly818/ap818/bin/perl-static /home/fly818/var/megalib/ExtUtils/xsubpp -typemap /home/fly818/ap818/lib/ExtUtils/typemap -typemap typemap HiRes.xs > HiRes.xsc && mv HiRes.xsc HiRes.c gcc -c -D_REENTRANT -D_GNU_SOURCE -DTHREADS_HAVE_PIDS -DUSE_SITECUSTOMIZE -DNO_HASH_SEED -fno-strict-aliasing -pipe -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -I/usr/include/gdbm -O2 -DVERSION=\"1.9724\" -DXS_VERSION=\"1.9724\" -fpic "-I/home/fly818/ap818/lib/CORE" -DTIME_HIRES_NANOSLEEP -DTIME_HIRES_CLOCK_GETTIME -DTIME_HIRES_CLOCK_GETRES -DTIME_HIRES_CLOCK -DTIME_HIRES_STAT=4 -DATLEASTFIVEOHOHFIVE HiRes.c Running Mkbootstrap for Time::HiRes () chmod 644 HiRes.bs rm -f blib/arch/auto/Time/HiRes/HiRes.so LD_RUN_PATH="/lib" gcc -shared HiRes.o -o blib/arch/auto/Time/HiRes/HiRes.so \ -lrt \ chmod 755 blib/arch/auto/Time/HiRes/HiRes.so cp HiRes.bs blib/arch/auto/Time/HiRes/HiRes.bs chmod 644 blib/arch/auto/Time/HiRes/HiRes.bs Manifying blib/man3/Time::HiRes.3 ZEFRAM/Time-HiRes-1.9724.tar.gz make -- OK Running make test >>> make test TEST_VERBOSE=1 PERL_DL_NONLAZY=1 /home/fly818/ap818/bin/perl-static "-MExtUtils::Command::MM" "-e" "test_harness(1, 'blib/lib', 'blib/arch')" t/*.t t/alarm.t ......... 1..10 # I am the main process 2781, starting the watchdog process... # I am the watchdog process 2782, sleeping for 360 seconds... # The watchdog process 2782 launched, continuing testing... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.329676 # Select returned! 4 0.329999 # 0.890000333333333 # Tick! 3 0.756611 # Select returned! 3 0.75691 # 0.747696666666667 # Tick! 2 1.049661 # Select returned! 2 1.04993 # 0.650023333333333 # Tick! 1 1.349667 # Select returned! 1 1.349942 # 0.550019333333333 # Tick! 0 1.760251 # Select returned! 0 1.760585 # 0.413138333333333 ok 2 # 0 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1307747248.19661, t0 = 1307747248.19651, dt = 9.20295715332031e-05 # N = 2048, t1 = 1307747248.19695, t0 = 1307747248.19676, dt = 0.000182151794433594 # N = 4096, t1 = 1307747248.19748, t0 = 1307747248.19712, dt = 0.000359058380126953 # N = 8192, t1 = 1307747248.19836, t0 = 1307747248.19763, dt = 0.000734090805053711 # N = 16384, t1 = 1307747248.20005, t0 = 1307747248.19852, dt = 0.00152015686035156 # N = 32768, t1 = 1307747248.20315, t0 = 1307747248.20022, dt = 0.00292396545410156 # N = 65536, t1 = 1307747248.20964, t0 = 1307747248.20338, dt = 0.00626492500305176 # N = 131072, t1 = 1307747248.22113, t0 = 1307747248.20994, dt = 0.0111880302429199 # Alarm 1 - 1307747248.22526 # Alarm 2 - 1307747248.24895 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 2781, terminating the watchdog process 2782 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 2782 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 2783, starting the watchdog process... # I am the watchdog process 2784, sleeping for 360 seconds... # The watchdog process 2784 launched, continuing testing... ok 1 - require Time::HiRes; # have_clock_gettime = 1 # have_clock_getres = 1 # have_clock_nanosleep = 0 # have_clock = 1 # CLOCK_REALTIME: try = 1 # t1 = 1307747253.93435, t0 = 1307747252.41792 # dt = 1.51642799377441, rt = 0.0109519958496094 ok 2 ok 3 ok 4 # skip no clock_nanosleep # clock = 0.03 # clock = 0.03 0.09 # clock = 0.03 0.09 0.15 # clock = 0.03 0.09 0.15 0.22 ok 5 # I am the main process 2783, terminating the watchdog process 2784 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 2784 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 2785, starting the watchdog process... # I am the watchdog process 2786, sleeping for 360 seconds... # The watchdog process 2786 launched, continuing testing... # gettimeofday returned 2 args ok 1 ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 2785, terminating the watchdog process 2786 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 2786 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 2787, starting the watchdog process... # I am the watchdog process 2788, sleeping for 360 seconds... # The watchdog process 2788 launched, continuing testing... # setitimer: 0 0 ok 1 # getitimer: 0.51 0.4 # Tick! 2 0.550114 # Tick! 1 1.100074 # Tick! 0 1.540096 # Tick! 0 2.089953 # getitimer: 0 0 ok 2 # I am the main process 2787, terminating the watchdog process 2788 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 2788 = 1 # All done. ok t/nanosleep.t ..... 1..3 # I am the main process 2789, starting the watchdog process... # I am the watchdog process 2790, sleeping for 360 seconds... # The watchdog process 2790 launched, continuing testing... ok 1 - negative time error ok 2 ok 3 # I am the main process 2789, terminating the watchdog process 2790 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 2790 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 2791, starting the watchdog process... # I am the watchdog process 2792, sleeping for 360 seconds... # The watchdog process 2792 launched, continuing testing... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1307747258.01585 ok 3 # sleep...0.508086 ok 4 # I am the main process 2791, terminating the watchdog process 2792 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 2792 = 1 # All done. ok t/stat.t .......... 1..1 # I am the main process 2793, starting the watchdog process... # I am the watchdog process 2794, sleeping for 360 seconds... # The watchdog process 2794 launched, continuing testing... # mtime = 1307747258 1307747258 1307747259 1307747259 1307747259 # atime = 1307747258 1307747259 1307747259 1307747259 1307747260 # ai = 4, mi = 4, ss = 0 ok 1 # skip no subsecond timestamps detected # I am the main process 2793, terminating the watchdog process 2794 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 2794 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 2795, starting the watchdog process... # I am the watchdog process 2796, sleeping for 360 seconds... # The watchdog process 2796 launched, continuing testing... ok 1 - require Time::HiRes; ok 2 # s = 19.0369117259979, n = 100, s/n = 0.190369117259979 # I am the main process 2795, terminating the watchdog process 2796 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 2796 = 1 # All done. ok t/tv_interval.t ... 1..2 ok 1 - require Time::HiRes; ok 2 ok t/ualarm.t ........ 1..12 # I am the main process 2798, starting the watchdog process... # I am the watchdog process 2799, sleeping for 360 seconds... # The watchdog process 2799 launched, continuing testing... ok 1 # tick = 1, one = 1307747260, two = 1307747260, three = 1307747260 ok 2 # tick = 3, one = 1307747260, two = 1307747260, three = 1307747260 ok 3 - negative time error # t0 = 1307747260.29543 # ualarm(100000) # t1 = 1307747260.39543 # dt = 0.099998950958252 # r = 0.99998950958252 ok 4 # t0 = 1307747260.39644 # ualarm(1100000) # t1 = 1307747261.49456 # dt = 1.09811496734619 # r = 0.998286333951083 ok 5 # t0 = 1307747261.49555 # ualarm(2200000) # t1 = 1307747263.69446 # dt = 2.19891881942749 # r = 0.999508554285223 ok 6 # t0 = 1307747263.69537 # ualarm(4300000) # t1 = 1307747267.99458 # dt = 4.29921293258667 # r = 0.999816961066668 ok 7 # t0 = 1307747267.99507 # got0 = 0 # t1 = 1307747268.29508 # t1 - t0 = 0.300007104873657 # got1 = 200000 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 2798, terminating the watchdog process 2799 before it terminates me in 352 seconds (testing took 8 seconds). # kill KILL 2799 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 2800, starting the watchdog process... # I am the watchdog process 2801, sleeping for 360 seconds... # The watchdog process 2801 launched, continuing testing... ok 1 - negative time error ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 2800, terminating the watchdog process 2801 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 2801 = 1 # All done. ok All tests successful. Files=11, Tests=53, 26 wallclock secs ( 0.05 usr 0.02 sys + 10.88 cusr 1.61 csys = 12.56 CPU) Result: PASS ZEFRAM/Time-HiRes-1.9724.tar.gz make test TEST_VERBOSE=1 -- OK Andrew Main (Zefram) <zefram@fysh.org> High resolution alarm, sleep, gettimeofday, interval timers >>> (cd /home/fly818/var/cpan/build/Time-HiRes-1.9724-LJrV2h && tar cvf - Time-HiRes-1.9724.ppd blib) | gzip -c >/home/fly818/var/REPO/Z/ZE/ZEFRAM/Time-HiRes-1.9724.tar.gz Time-HiRes-1.9724.ppd blib/ blib/lib/ blib/lib/Time/ blib/lib/Time/HiRes.pm blib/arch/ blib/arch/auto/ blib/arch/auto/Time/ blib/arch/auto/Time/HiRes/ blib/arch/auto/Time/HiRes/HiRes.so blib/arch/auto/Time/HiRes/HiRes.bs blib/man3/ blib/man3/Time::HiRes.3 >>> mv /home/fly818/var/cpan/build/Time-HiRes-1.9724-LJrV2h/Time-HiRes-1.9724.ppd /home/fly818/var/REPO/Z/ZE/ZEFRAM Finished 2011-06-10T16:07:52