PATH=/opt/SUNWspro/bin:/usr/local/bin:/opt/csw/bin:/usr/ccs/bin:/usr/bin:/usr/sbin Start 2012-03-11T11:56:37 ActivePerl-1205 CPAN-1.9402 Going to read '/export/home/fly1232/var/cpan/Metadata' Database was generated on Sun, 11 Mar 2012 17:11:44 GMT Running make for Z/ZE/ZEFRAM/Time-HiRes-1.9725.tar.gz Checksum for /net/nas/data/cpan/authors/id/Z/ZE/ZEFRAM/Time-HiRes-1.9725.tar.gz ok Time-HiRes-1.9725/ Time-HiRes-1.9725/META.yml Time-HiRes-1.9725/MANIFEST Time-HiRes-1.9725/HiRes.pm Time-HiRes-1.9725/Changes Time-HiRes-1.9725/ppport.h Time-HiRes-1.9725/README Time-HiRes-1.9725/hints/ Time-HiRes-1.9725/hints/aix.pl Time-HiRes-1.9725/hints/dynixptx.pl Time-HiRes-1.9725/hints/solaris.pl Time-HiRes-1.9725/hints/linux.pl Time-HiRes-1.9725/hints/irix.pl Time-HiRes-1.9725/hints/dec_osf.pl Time-HiRes-1.9725/hints/svr4.pl Time-HiRes-1.9725/hints/sco.pl Time-HiRes-1.9725/TODO Time-HiRes-1.9725/HiRes.xs Time-HiRes-1.9725/fallback/ Time-HiRes-1.9725/fallback/const-c.inc Time-HiRes-1.9725/fallback/const-xs.inc Time-HiRes-1.9725/typemap Time-HiRes-1.9725/Makefile.PL Time-HiRes-1.9725/META.json Time-HiRes-1.9725/t/ Time-HiRes-1.9725/t/Watchdog.pm Time-HiRes-1.9725/t/sleep.t Time-HiRes-1.9725/t/nanosleep.t Time-HiRes-1.9725/t/itimer.t Time-HiRes-1.9725/t/usleep.t Time-HiRes-1.9725/t/ualarm.t Time-HiRes-1.9725/t/clock.t Time-HiRes-1.9725/t/gettimeofday.t Time-HiRes-1.9725/t/time.t Time-HiRes-1.9725/t/tv_interval.t Time-HiRes-1.9725/t/stat.t Time-HiRes-1.9725/t/alarm.t CPAN.pm: Going to build Z/ZE/ZEFRAM/Time-HiRes-1.9725.tar.gz >>> /export/home/fly1232/bin/perl Makefile.PL Configuring Time::HiRes... Using hints hints/solaris.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/solaris.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 Writing MYMETA.yml and MYMETA.json Now you may issue 'make'. Do not forget also 'make test'. >>> make cp HiRes.pm blib/lib/Time/HiRes.pm /export/home/fly1232/bin/perl /export/home/fly1232/ap1205/lib/ExtUtils/xsubpp -typemap /export/home/fly1232/ap1205/lib/ExtUtils/typemap -typemap typemap HiRes.xs > HiRes.xsc && mv HiRes.xsc HiRes.c cc -c -D_REENTRANT -DUSE_SITECUSTOMIZE -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -O -DVERSION=\"1.9725\" -DXS_VERSION=\"1.9725\" -KPIC "-I/export/home/fly1232/ap1205/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="/usr/lib" cc -G -L/usr/lib -L/usr/ccs/lib -L/opt/SUNWspro/prod/lib/v8plus -L/opt/SUNWspro/prod/lib -L/lib 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.9725.tar.gz make -- OK Running make test >>> make test TEST_VERBOSE=1 PERL_DL_NONLAZY=1 /export/home/fly1232/bin/perl "-MExtUtils::Command::MM" "-e" "test_harness(1, 'blib/lib', 'blib/arch')" t/*.t t/alarm.t ......... 1..10 # I am the main process 5195, starting the watchdog process... # The watchdog process 5199 launched, continuing testing... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # I am the watchdog process 5199, sleeping for 360 seconds... # Tick! 4 0.3543 # Select returned! 4 0.354747 # 0.881751 # Tick! 3 0.663978 # Select returned! 3 0.664384 # 0.778538666666667 # Tick! 2 0.973914 # Select returned! 2 0.974328 # 0.675224 # Tick! 1 1.28416 # Select returned! 1 1.284521 # 0.571826333333333 # Tick! 0 1.594176 # Select returned! 0 1.594505 # 0.468498333333333 ok 2 # 0 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1331492227.06298, t0 = 1331492227.06267, dt = 0.000313043594360352 # N = 2048, t1 = 1331492227.06371, t0 = 1331492227.0631, dt = 0.000613927841186523 # N = 4096, t1 = 1331492227.06504, t0 = 1331492227.06381, dt = 0.00122499465942383 # N = 8192, t1 = 1331492227.06756, t0 = 1331492227.06512, dt = 0.00244498252868652 # N = 16384, t1 = 1331492227.07262, t0 = 1331492227.06764, dt = 0.00497317314147949 # N = 32768, t1 = 1331492227.08254, t0 = 1331492227.07271, dt = 0.00982308387756348 # N = 65536, t1 = 1331492227.10222, t0 = 1331492227.08263, dt = 0.0195889472961426 # Alarm 1 - 1331492227.1196 # Alarm 2 - 1331492227.17232 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 5195, terminating the watchdog process 5199 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 5199 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 5430, starting the watchdog process... # I am the watchdog process 5431, sleeping for 360 seconds... # The watchdog process 5431 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 = 1331492233.46949, t0 = 1331492231.95132 # dt = 1.51817107200623, rt = 0.0121140480041504 ok 2 ok 3 ok 4 # skip no clock_nanosleep # clock = 0 # clock = 0 0.31 # clock = 0 0.31 0.64 # clock = 0 0.31 0.64 0.95 ok 5 # I am the main process 5430, terminating the watchdog process 5431 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 5431 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 5530, starting the watchdog process... # I am the watchdog process 5533, sleeping for 360 seconds... # The watchdog process 5533 launched, continuing testing... # gettimeofday returned 2 args ok 1 ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 5530, terminating the watchdog process 5533 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 5533 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 5557, starting the watchdog process... # The watchdog process 5558 launched, continuing testing... # setitimer: 0 0 ok 1 # getitimer: 0.49 0.4 # I am the watchdog process 5558, sleeping for 360 seconds... # Tick! 2 0.507797 # Tick! 1 1.307452 # Tick! 0 1.757419 # Tick! 0 2.377432 # getitimer: 0 0 ok 2 # I am the main process 5557, terminating the watchdog process 5558 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 5558 = 1 # All done. ok t/nanosleep.t ..... 1..3 # I am the main process 5619, starting the watchdog process... # I am the watchdog process 5621, sleeping for 360 seconds... # The watchdog process 5621 launched, continuing testing... ok 1 - negative time error ok 2 ok 3 # I am the main process 5619, terminating the watchdog process 5621 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 5621 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 5696, starting the watchdog process... # I am the watchdog process 5700, sleeping for 360 seconds... # The watchdog process 5700 launched, continuing testing... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1331492239.36291 ok 3 # sleep...0.665376 ok 4 # I am the main process 5696, terminating the watchdog process 5700 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 5700 = 1 # All done. ok t/stat.t .......... 1..16 # I am the main process 5722, starting the watchdog process... # The watchdog process 5730 launched, continuing testing... # I am the watchdog process 5730, sleeping for 360 seconds... ok 1 ok 2 ok 3 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 ok 11 ok 12 ok 13 ok 14 ok 15 # mtime = 1331492240.64458 1331492241.10032 1331492241.43953 1331492241.72956 1331492242.09999 # atime = 1331492240.92005 1331492241.23966 1331492241.58936 1331492241.92986 1331492242.28959 # ai = 4, mi = 4, ss = 8 ok 16 # I am the main process 5722, terminating the watchdog process 5730 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 5730 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 5781, starting the watchdog process... # I am the watchdog process 5782, sleeping for 360 seconds... # The watchdog process 5782 launched, continuing testing... ok 1 - require Time::HiRes; ok 2 # s = 43.8767035007477, n = 100, s/n = 0.438767035007477 # I am the main process 5781, terminating the watchdog process 5782 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 5782 = 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 5786, starting the watchdog process... # The watchdog process 5788 launched, continuing testing... ok 1 # tick = 1, one = 1331492242, two = 1331492242, three = 1331492242 ok 2 # tick = 3, one = 1331492242, two = 1331492242, three = 1331492242 ok 3 - negative time error # t0 = 1331492243.02144 # ualarm(100000) # I am the watchdog process 5788, sleeping for 360 seconds... # t1 = 1331492243.12975 # dt = 0.108315944671631 # r = 1.08315944671631 ok 4 # t0 = 1331492243.13092 # ualarm(1100000) # t1 = 1331492244.24007 # dt = 1.10915493965149 # r = 1.00832267241044 ok 5 # t0 = 1331492244.243 # ualarm(2200000) # t1 = 1331492246.50924 # dt = 2.26624512672424 # r = 1.03011142123829 ok 6 # t0 = 1331492246.51048 # ualarm(4300000) # t1 = 1331492250.81932 # dt = 4.30883502960205 # r = 1.00205465804699 ok 7 # t0 = 1331492250.82222 # got0 = 0 # t1 = 1331492251.12222 # t1 - t0 = 0.300000905990601 # got1 = 200004 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 5786, terminating the watchdog process 5788 before it terminates me in 351 seconds (testing took 9 seconds). # kill KILL 5788 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 6163, starting the watchdog process... # I am the watchdog process 6165, sleeping for 360 seconds... # The watchdog process 6165 launched, continuing testing... ok 1 - negative time error ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 6163, terminating the watchdog process 6165 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 6165 = 1 # All done. ok All tests successful. Files=11, Tests=68, 30 wallclock secs ( 0.19 usr 0.11 sys + 13.70 cusr 0.26 csys = 14.26 CPU) Result: PASS ZEFRAM/Time-HiRes-1.9725.tar.gz make test TEST_VERBOSE=1 -- OK Andrew Main (Zefram) <zefram@fysh.org> High resolution alarm, sleep, gettimeofday, interval timers >>> (cd /export/home/fly1232/var/cpan/build/Time-HiRes-1.9725-fuGNZb && tar cvf - Time-HiRes-1.9725.ppd blib) | gzip -c >/export/home/fly1232/var/REPO/Z/ZE/ZEFRAM/Time-HiRes-1.9725.tar.gz Time-HiRes-1.9725.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 /export/home/fly1232/var/cpan/build/Time-HiRes-1.9725-fuGNZb/Time-HiRes-1.9725.ppd /export/home/fly1232/var/REPO/Z/ZE/ZEFRAM Finished 2012-03-11T11:57:39