PATH=/Users/fly1800/bin:/Users/fly1800/ap1800-297214/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin Start 2013-06-09T02:03:20 ActivePerl-1800 CPAN-1.9800 Reading '/Users/fly1800/var/cpan/Metadata' Database was generated on Sun, 09 Jun 2013 08:17:02 GMT ______________________ D i s t r o P r e f s ______________________ Time-HiRes.yml[0] 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 Applying 1 patch: /Users/fly1800/etc/distroprefs/Time-HiRes-1.9719.patch /usr/bin/patch -N --fuzz=3 -p1 <= IV_1E6 || uinterval >= IV_1E6) - croak("Time::HiRes::ualarm(%d, %d): useconds or uinterval equal to or more than %"IVdf, useconds, uinterval, IV_1E6); RETVAL = ualarm(useconds, uinterval); #endif @@ -948,8 +946,6 @@ } } #else - if (useconds >= IV_1E6 || uinterval >= IV_1E6) - croak("Time::HiRes::alarm(%d, %d): seconds or interval equal to or more than 1.0 ", useconds, uinterval, IV_1E6); RETVAL = (NV)ualarm( useconds, uinterval ) / NV_1E6; #endif } EOT patching file HiRes.xs Hunk #1 succeeded at 925 (offset 5 lines). Hunk #2 succeeded at 953 (offset 7 lines). CPAN.pm: Building Z/ZE/ZEFRAM/Time-HiRes-1.9725.tar.gz >>> /Users/fly1800/ap1800-297214/bin/perl-dynamic Makefile.PL Configuring Time::HiRes... 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()... NOT found. Looking for clock_getres()... NOT found. Looking for clock_nanosleep()... NOT found. Looking for clock()... found. Looking for stat() subsecond timestamps... Trying struct stat st_atimespec.tv_nsec...found. Trying struct stat st_atimensec...NOT found. Trying struct stat st_atime_n...NOT found. Trying struct stat st_atim.tv_nsec...NOT found. Trying struct stat st_uatime...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 /Users/fly1800/ap1800-297214/bin/perl-dynamic /Users/fly1800/ap1800-297214/lib/ExtUtils/xsubpp -typemap /Users/fly1800/ap1800-297214/lib/ExtUtils/typemap -typemap typemap HiRes.xs > HiRes.xsc && mv HiRes.xsc HiRes.c gcc -c -fno-common -DPERL_DARWIN -no-cpp-precomp -arch x86_64 -DUSE_SITECUSTOMIZE -DPERL_RELOCATABLE_INCPUSH -fno-merge-constants -fno-strict-aliasing -pipe -fstack-protector -O3 -DVERSION=\"1.9725\" -DXS_VERSION=\"1.9725\" "-I/Users/fly1800/ap1800-297214/lib/CORE" -DTIME_HIRES_NANOSLEEP -DTIME_HIRES_CLOCK -DTIME_HIRES_STAT=1 -DATLEASTFIVEOHOHFIVE HiRes.c Running Mkbootstrap for Time::HiRes () chmod 644 HiRes.bs rm -f blib/arch/auto/Time/HiRes/HiRes.bundle cc -mmacosx-version-min=10.5 -bundle -undefined dynamic_lookup -Wl,-search_paths_first -arch x86_64 -fstack-protector HiRes.o -o blib/arch/auto/Time/HiRes/HiRes.bundle \ \ chmod 755 blib/arch/auto/Time/HiRes/HiRes.bundle 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 /Users/fly1800/ap1800-297214/bin/perl-dynamic "-MExtUtils::Command::MM" "-e" "test_harness(1, 'blib/lib', 'blib/arch')" t/*.t t/alarm.t ......... 1..10 # I am the main process 77146, starting the watchdog process... # The watchdog process 77147 launched, continuing testing... # I am the watchdog process 77147, sleeping for 360 seconds... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.302935 # Select returned! 4 0.303004 # 0.898998666666667 # Tick! 3 0.603079 # Select returned! 3 0.60313 # 0.798956666666667 # Tick! 2 0.90325 # Select returned! 2 0.90337 # 0.698876666666667 # Tick! 1 1.203464 # Select returned! 1 1.203512 # 0.598829333333333 # Tick! 0 1.503595 # Select returned! 0 1.503641 # 0.498786333333333 ok 2 # 0 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1370768611.0278, t0 = 1370768611.02773, dt = 6.79492950439453e-05 # N = 2048, t1 = 1370768611.02798, t0 = 1370768611.02784, dt = 0.000132083892822266 # N = 4096, t1 = 1370768611.02827, t0 = 1370768611.02801, dt = 0.000261068344116211 # N = 8192, t1 = 1370768611.02883, t0 = 1370768611.0283, dt = 0.000526905059814453 # N = 16384, t1 = 1370768611.02991, t0 = 1370768611.02886, dt = 0.00105595588684082 # N = 32768, t1 = 1370768611.03205, t0 = 1370768611.02994, dt = 0.0021059513092041 # N = 65536, t1 = 1370768611.03627, t0 = 1370768611.03208, dt = 0.00419306755065918 # N = 131072, t1 = 1370768611.05466, t0 = 1370768611.03631, dt = 0.0183570384979248 # Alarm 1 - 1370768611.067 # Alarm 2 - 1370768611.09359 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 77146, terminating the watchdog process 77147 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 77147 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 77148, starting the watchdog process... # The watchdog process 77149 launched, continuing testing... # I am the watchdog process 77149, sleeping for 360 seconds... ok 1 - require Time::HiRes; # have_clock_gettime = 0 # have_clock_getres = 0 # have_clock_nanosleep = 0 # have_clock = 1 ok 2 # skip no clock_gettime ok 3 # skip no clock_getres ok 4 # skip no clock_nanosleep # clock = 0.042839 # clock = 0.042839 0.105906 # clock = 0.042839 0.105906 0.168963 # clock = 0.042839 0.105906 0.168963 0.232415 ok 5 # I am the main process 77148, terminating the watchdog process 77149 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 77149 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 77150, starting the watchdog process... # The watchdog process 77151 launched, continuing testing... # I am the watchdog process 77151, sleeping for 360 seconds... # gettimeofday returned 2 args ok 1 ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 77150, terminating the watchdog process 77151 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 77151 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 77152, starting the watchdog process... # I am the watchdog process 77153, sleeping for 360 seconds... # The watchdog process 77153 launched, continuing testing... # setitimer: 0 0 ok 1 # getitimer: 0.497788 0.4 # Tick! 2 0.752492 # Tick! 1 1.349937 # Tick! 0 1.973582 # Tick! 0 2.584506 # getitimer: 0 0 ok 2 # I am the main process 77152, terminating the watchdog process 77153 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 77153 = 1 # All done. ok t/nanosleep.t ..... 1..3 # I am the main process 77154, starting the watchdog process... # The watchdog process 77155 launched, continuing testing... # I am the watchdog process 77155, sleeping for 360 seconds... ok 1 - negative time error ok 2 ok 3 # I am the main process 77154, terminating the watchdog process 77155 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 77155 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 77156, starting the watchdog process... # The watchdog process 77157 launched, continuing testing... # I am the watchdog process 77157, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1370768619.87118 ok 3 # sleep...0.500016 ok 4 # I am the main process 77156, terminating the watchdog process 77157 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 77157 = 1 # All done. ok t/stat.t .......... 1..16 # I am the main process 77158, starting the watchdog process... # The watchdog process 77159 launched, continuing testing... # I am the watchdog process 77159, 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 = 1370768620 1370768620 1370768621 1370768621 1370768621 # atime = 1370768620 1370768621 1370768621 1370768621 1370768621 # ai = 4, mi = 4, ss = 0 ok 16 # skip no subsecond timestamps detected # I am the main process 77158, terminating the watchdog process 77159 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 77159 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 77160, starting the watchdog process... # The watchdog process 77161 launched, continuing testing... # I am the watchdog process 77161, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 # s = 4.97568893432617, n = 100, s/n = 0.0497568893432617 # I am the main process 77160, terminating the watchdog process 77161 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 77161 = 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 77163, starting the watchdog process... # The watchdog process 77164 launched, continuing testing... # I am the watchdog process 77164, sleeping for 360 seconds... ok 1 # tick = 1, one = 1370768622, two = 1370768622, three = 1370768622 ok 2 # tick = 3, one = 1370768622, two = 1370768622, three = 1370768622 ok 3 - negative time error # t0 = 1370768622.21562 # ualarm(100000) # t1 = 1370768622.31586 # dt = 0.100241899490356 # r = 1.00241899490356 ok 4 # t0 = 1370768622.31653 # ualarm(1100000) # t1 = 1370768623.41681 # dt = 1.10027980804443 # r = 1.00025437094949 ok 5 # t0 = 1370768623.41779 # ualarm(2200000) # t1 = 1370768625.61805 # dt = 2.20026016235352 # r = 1.00011825561523 ok 6 # t0 = 1370768625.61844 # ualarm(4300000) # t1 = 1370768629.91847 # dt = 4.30003595352173 # r = 1.00000836128412 ok 7 # t0 = 1370768629.91943 # got0 = 0 # t1 = 1370768630.21943 # t1 - t0 = 0.300000905990601 # got1 = 199984 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 77163, terminating the watchdog process 77164 before it terminates me in 352 seconds (testing took 8 seconds). # kill KILL 77164 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 77165, starting the watchdog process... # The watchdog process 77166 launched, continuing testing... # I am the watchdog process 77166, sleeping for 360 seconds... ok 1 - negative time error ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 77165, terminating the watchdog process 77166 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 77166 = 1 # All done. ok All tests successful. Files=11, Tests=68, 25 wallclock secs ( 0.08 usr 0.03 sys + 10.45 cusr 0.14 csys = 10.70 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 /Users/fly1800/var/cpan/build/Time-HiRes-1.9725-5ZXbns && tar cvf - Time-HiRes-1.9725.ppd blib) | gzip -c >/Users/fly1800/var/REPO/Z/ZE/ZEFRAM/Time-HiRes-1.9725.tar.gz Time-HiRes-1.9725.ppd blib/ blib/arch/ blib/arch/auto/ blib/arch/auto/Time/ blib/arch/auto/Time/HiRes/ blib/arch/auto/Time/HiRes/HiRes.bs blib/arch/auto/Time/HiRes/HiRes.bundle blib/lib/ blib/lib/Time/ blib/lib/Time/HiRes.pm blib/man3/ blib/man3/Time::HiRes.3 >>> mv /Users/fly1800/var/cpan/build/Time-HiRes-1.9725-5ZXbns/Time-HiRes-1.9725.ppd /Users/fly1800/var/REPO/Z/ZE/ZEFRAM Finished 2013-06-09T02:03:56