PATH=/home/fly2200/bin:/home/fly2200/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/data/fly2200/var/megalib/bin Start 2015-06-10T14:21:35 ActivePerl-2200 CPAN-2.00 Reading '/data/fly2200/var/cpan/Metadata' Database was generated on Wed, 10 Jun 2015 05:17:02 GMT Running make for Z/ZE/ZEFRAM/Time-HiRes-1.9726.tar.gz Fetching with LWP: http://cpan.nas1.activestate.com/authors/id/Z/ZE/ZEFRAM/Time-HiRes-1.9726.tar.gz Checksum for /data/fly2200/var/cpan/sources/authors/id/Z/ZE/ZEFRAM/Time-HiRes-1.9726.tar.gz ok Time-HiRes-1.9726/ Time-HiRes-1.9726/HiRes.pm Time-HiRes-1.9726/MANIFEST Time-HiRes-1.9726/Makefile.PL Time-HiRes-1.9726/HiRes.xs Time-HiRes-1.9726/META.json Time-HiRes-1.9726/META.yml Time-HiRes-1.9726/README Time-HiRes-1.9726/TODO Time-HiRes-1.9726/Changes Time-HiRes-1.9726/fallback/ Time-HiRes-1.9726/fallback/const-xs.inc Time-HiRes-1.9726/fallback/const-c.inc Time-HiRes-1.9726/t/ Time-HiRes-1.9726/t/usleep.t Time-HiRes-1.9726/t/time.t Time-HiRes-1.9726/t/itimer.t Time-HiRes-1.9726/t/stat.t Time-HiRes-1.9726/t/Watchdog.pm Time-HiRes-1.9726/t/tv_interval.t Time-HiRes-1.9726/t/gettimeofday.t Time-HiRes-1.9726/t/sleep.t Time-HiRes-1.9726/t/clock.t Time-HiRes-1.9726/t/alarm.t Time-HiRes-1.9726/t/nanosleep.t Time-HiRes-1.9726/t/ualarm.t Time-HiRes-1.9726/hints/ Time-HiRes-1.9726/hints/sco.pl Time-HiRes-1.9726/hints/dec_osf.pl Time-HiRes-1.9726/hints/aix.pl Time-HiRes-1.9726/hints/irix.pl Time-HiRes-1.9726/hints/svr4.pl Time-HiRes-1.9726/hints/linux.pl Time-HiRes-1.9726/hints/dynixptx.pl Time-HiRes-1.9726/hints/solaris.pl Time-HiRes-1.9726/ppport.h Time-HiRes-1.9726/typemap CPAN.pm: Building Z/ZE/ZEFRAM/Time-HiRes-1.9726.tar.gz >>> /data/fly2200/ap2200-299134/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()... 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 Generating a Unix-style Makefile 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 Running Mkbootstrap for Time::HiRes () chmod 644 "HiRes.bs" "/data/fly2200/ap2200-299134/bin/perl-static" "/home/fly2200/ap2200-299134/lib/ExtUtils/xsubpp" -typemap "/home/fly2200/ap2200-299134/lib/ExtUtils/typemap" -typemap "typemap" HiRes.xs > HiRes.xsc && mv HiRes.xsc HiRes.c gcc -c -D_REENTRANT -D_GNU_SOURCE -DUSE_SITECUSTOMIZE -DPERL_RELOCATABLE_INCPUSH -fno-merge-constants -fwrapv -fno-strict-aliasing -pipe -fstack-protector -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -O2 -DVERSION=\"1.9726\" -DXS_VERSION=\"1.9726\" -fPIC "-I/home/fly2200/ap2200-299134/lib/CORE" -DTIME_HIRES_NANOSLEEP -DTIME_HIRES_CLOCK_GETTIME -DTIME_HIRES_CLOCK_GETRES -DTIME_HIRES_CLOCK_NANOSLEEP -DTIME_HIRES_CLOCK -DTIME_HIRES_STAT=4 -DATLEASTFIVEOHOHFIVE HiRes.c rm -f blib/arch/auto/Time/HiRes/HiRes.so LD_RUN_PATH="/lib/x86_64-linux-gnu" gcc -shared -O2 -fstack-protector HiRes.o -o blib/arch/auto/Time/HiRes/HiRes.so \ -lrt \ chmod 755 blib/arch/auto/Time/HiRes/HiRes.so "/data/fly2200/ap2200-299134/bin/perl-static" -MExtUtils::Command::MM -e 'cp_nonempty' -- HiRes.bs blib/arch/auto/Time/HiRes/HiRes.bs 644 Manifying 1 pod document ZEFRAM/Time-HiRes-1.9726.tar.gz make -- OK Running make test >>> make test TEST_VERBOSE=1 Running Mkbootstrap for Time::HiRes () chmod 644 "HiRes.bs" PERL_DL_NONLAZY=1 "/data/fly2200/ap2200-299134/bin/perl-static" "-MExtUtils::Command::MM" "-MTest::Harness" "-e" "undef *Test::Harness::Switches; test_harness(1, 'blib/lib', 'blib/arch')" t/*.t t/alarm.t ......... 1..10 # I am the main process 21103, starting the watchdog process... # The watchdog process 21104 launched, continuing testing... # I am the watchdog process 21104, sleeping for 360 seconds... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.300394 # Select returned! 4 0.300618 # 0.899794 # Tick! 3 0.602236 # Select returned! 3 0.602435 # 0.799188333333333 # Tick! 2 0.902659 # Select returned! 2 0.902911 # 0.699029666666667 # Tick! 1 1.203188 # Select returned! 1 1.203389 # 0.598870333333333 # Tick! 0 1.503635 # Select returned! 0 1.503869 # 0.498710333333333 ok 2 # 0 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1433971309.64968, t0 = 1433971309.64959, dt = 9.51290130615234e-05 # N = 2048, t1 = 1433971309.64994, t0 = 1433971309.64978, dt = 0.000156879425048828 # N = 4096, t1 = 1433971309.65031, t0 = 1433971309.65001, dt = 0.000300168991088867 # N = 8192, t1 = 1433971309.65098, t0 = 1433971309.65039, dt = 0.00059199333190918 # N = 16384, t1 = 1433971309.65658, t0 = 1433971309.65105, dt = 0.00552606582641602 # N = 32768, t1 = 1433971309.65907, t0 = 1433971309.65671, dt = 0.00236201286315918 # N = 65536, t1 = 1433971309.67245, t0 = 1433971309.65915, dt = 0.013300895690918 # Alarm 1 - 1433971309.68384 # Alarm 2 - 1433971309.70324 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 21103, terminating the watchdog process 21104 before it terminates me in 355 seconds (testing took 5 seconds). # kill KILL 21104 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 21108, starting the watchdog process... # The watchdog process 21109 launched, continuing testing... # I am the watchdog process 21109, sleeping for 360 seconds... ok 1 - require Time::HiRes; # have_clock_gettime = 1 # have_clock_getres = 1 # have_clock_nanosleep = 1 # have_clock = 1 # CLOCK_REALTIME: try = 1 # t1 = 1433971315.44877, t0 = 1433971313.94767 # dt = 1.5011031627655, rt = 0.000735441843668694 ok 2 ok 3 ok 4 # clock = 0.05 # clock = 0.05 0.12 # clock = 0.05 0.12 0.18 # clock = 0.05 0.12 0.18 0.24 ok 5 # I am the main process 21108, terminating the watchdog process 21109 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 21109 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 21118, starting the watchdog process... # The watchdog process 21119 launched, continuing testing... # I am the watchdog process 21119, 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 21118, terminating the watchdog process 21119 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 21119 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 21123, starting the watchdog process... # The watchdog process 21124 launched, continuing testing... # setitimer: 0 0 # I am the watchdog process 21124, sleeping for 360 seconds... ok 1 # getitimer: 0.496031 0.400025 # Tick! 2 0.884056 # Tick! 1 1.660751 # Tick! 0 2.447644 # Tick! 0 3.228016 # getitimer: 0 0 ok 2 # I am the main process 21123, terminating the watchdog process 21124 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 21124 = 1 # All done. ok t/nanosleep.t ..... 1..3 # I am the main process 21132, starting the watchdog process... # The watchdog process 21133 launched, continuing testing... # I am the watchdog process 21133, sleeping for 360 seconds... ok 1 - negative time error ok 2 ok 3 # I am the main process 21132, terminating the watchdog process 21133 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 21133 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 21136, starting the watchdog process... # The watchdog process 21138 launched, continuing testing... # I am the watchdog process 21138, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1433971322.65909 ok 3 # sleep...0.500149 ok 4 # I am the main process 21136, terminating the watchdog process 21138 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 21138 = 1 # All done. ok t/stat.t .......... 1..43 # I am the main process 21140, starting the watchdog process... # The watchdog process 21141 launched, continuing testing... # I am the watchdog process 21141, 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 ok 16 ok 17 ok 18 ok 19 ok 20 ok 21 ok 22 ok 23 ok 24 ok 25 ok 26 ok 27 ok 28 ok 29 ok 30 ok 31 ok 32 ok 33 ok 34 ok 35 # mtime = 1433971323.37615 1433971323.63615 1433971324.00015 1433971324.32815 1433971324.63215 # atime = 1433971323.53615 1433971323.81215 1433971324.14815 1433971324.49615 1433971324.82815 # ai = 4, mi = 4, ss = 8 ok 36 ok 37 ok 38 ok 39 ok 40 ok 41 ok 42 ok 43 # I am the main process 21140, terminating the watchdog process 21141 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 21141 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 21159, starting the watchdog process... # The watchdog process 21160 launched, continuing testing... # I am the watchdog process 21160, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 # s = 96.0771272182465, n = 100, s/n = 0.960771272182465 # I am the main process 21159, terminating the watchdog process 21160 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 21160 = 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 21162, starting the watchdog process... # I am the watchdog process 21163, sleeping for 360 seconds... # The watchdog process 21163 launched, continuing testing... ok 1 # tick = 1, one = 1433971325, two = 1433971325, three = 1433971325 ok 2 # tick = 3, one = 1433971325, two = 1433971325, three = 1433971325 ok 3 - negative time error # t0 = 1433971325.33032 # ualarm(100000) # t1 = 1433971325.43182 # dt = 0.101499080657959 # r = 1.01499080657959 ok 4 # t0 = 1433971325.43232 # ualarm(1100000) # t1 = 1433971326.53251 # dt = 1.10019183158875 # r = 1.0001743923534 ok 5 # t0 = 1433971326.53319 # ualarm(2200000) # t1 = 1433971328.73341 # dt = 2.20022010803223 # r = 1.00010004910556 ok 6 # t0 = 1433971328.73424 # ualarm(4300000) # t1 = 1433971333.03452 # dt = 4.30028295516968 # r = 1.00006580352783 ok 7 # t0 = 1433971333.03489 # got0 = 0 # t1 = 1433971333.33489 # t1 - t0 = 0.300000905990601 # got1 = 200000 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 21162, terminating the watchdog process 21163 before it terminates me in 352 seconds (testing took 8 seconds). # kill KILL 21163 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 21305, starting the watchdog process... # The watchdog process 21307 launched, continuing testing... # I am the watchdog process 21307, sleeping for 360 seconds... ok 1 - negative time error ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 21305, terminating the watchdog process 21307 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 21307 = 1 # All done. ok All tests successful. Files=11, Tests=95, 30 wallclock secs ( 0.12 usr 0.03 sys + 8.59 cusr 0.15 csys = 8.89 CPU) Result: PASS ZEFRAM/Time-HiRes-1.9726.tar.gz make test TEST_VERBOSE=1 -- OK Andrew Main (Zefram) <zefram@fysh.org> High resolution alarm, sleep, gettimeofday, interval timers >>> (cd /data/fly2200/var/cpan/build/Time-HiRes-1.9726-E4HxeD && tar cvf - Time-HiRes-1.9726.ppd blib) | gzip -c >/data/fly2200/var/REPO/Z/ZE/ZEFRAM/Time-HiRes-1.9726.tar.gz Time-HiRes-1.9726.ppd blib/ blib/man3/ blib/man3/Time::HiRes.3 blib/arch/ blib/arch/auto/ blib/arch/auto/Time/ blib/arch/auto/Time/HiRes/ blib/arch/auto/Time/HiRes/HiRes.so blib/lib/ blib/lib/Time/ blib/lib/Time/HiRes.pm >>> mv /data/fly2200/var/cpan/build/Time-HiRes-1.9726-E4HxeD/Time-HiRes-1.9726.ppd /data/fly2200/var/REPO/Z/ZE/ZEFRAM VmSize: 315432 kB Finished 2015-06-10T14:22:17