PATH=/usr/bin:/bin:/data/fly2200/cpanfly-5.22/var/megalib/bin Start 2016-06-30T02:06:42 ActivePerl-2200 CPAN-2.10 Reading '/data/fly2200/cpanfly-5.22/var/cpan/Metadata' Database was generated on Wed, 29 Jun 2016 05:53:43 GMT Checksum for /data/fly2200/cpanfly-5.22/var/cpan/sources/authors/id/J/JH/JHI/Time-HiRes-1.9739.tar.gz ok Time-HiRes-1.9739/ Time-HiRes-1.9739/Changes Time-HiRes-1.9739/fallback/ Time-HiRes-1.9739/hints/ Time-HiRes-1.9739/HiRes.pm Time-HiRes-1.9739/HiRes.xs Time-HiRes-1.9739/Makefile.PL Time-HiRes-1.9739/MANIFEST Time-HiRes-1.9739/META.json Time-HiRes-1.9739/META.yml Time-HiRes-1.9739/ppport.h Time-HiRes-1.9739/README Time-HiRes-1.9739/t/ Time-HiRes-1.9739/TODO Time-HiRes-1.9739/typemap Time-HiRes-1.9739/t/alarm.t Time-HiRes-1.9739/t/clock.t Time-HiRes-1.9739/t/gettimeofday.t Time-HiRes-1.9739/t/itimer.t Time-HiRes-1.9739/t/nanosleep.t Time-HiRes-1.9739/t/sleep.t Time-HiRes-1.9739/t/stat.t Time-HiRes-1.9739/t/time.t Time-HiRes-1.9739/t/tv_interval.t Time-HiRes-1.9739/t/ualarm.t Time-HiRes-1.9739/t/usleep.t Time-HiRes-1.9739/t/utime.t Time-HiRes-1.9739/t/Watchdog.pm Time-HiRes-1.9739/hints/aix.pl Time-HiRes-1.9739/hints/dec_osf.pl Time-HiRes-1.9739/hints/dynixptx.pl Time-HiRes-1.9739/hints/irix.pl Time-HiRes-1.9739/hints/linux.pl Time-HiRes-1.9739/hints/sco.pl Time-HiRes-1.9739/hints/solaris.pl Time-HiRes-1.9739/hints/svr4.pl Time-HiRes-1.9739/fallback/const-c.inc Time-HiRes-1.9739/fallback/const-xs.inc Configuring J/JH/JHI/Time-HiRes-1.9739.tar.gz with Makefile.PL >>> /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 futimens()... found. Looking for utimensat()... 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 Have /data/fly2200/cpanfly-5.22/var/megalib Want /home/fly2200/ap2200-299134/lib Your perl and your Config.pm seem to have different ideas about the architecture they are running on. Perl thinks: [megalib] Config says: [x86_64-linux-thread-multi] This may or may not cause problems. Please check your installation of perl if you have problems building this extension. 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'. JHI/Time-HiRes-1.9739.tar.gz /data/fly2200/ap2200-299134/bin/perl-static Makefile.PL -- OK Running make for J/JH/JHI/Time-HiRes-1.9739.tar.gz >>> 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" "/data/fly2200/cpanfly-5.22/var/megalib/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.9739\" -DXS_VERSION=\"1.9739\" -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 -DHAS_FUTIMENS -DHAS_UTIMENSAT -DTIME_HIRES_UTIME -DTIME_HIRES_STAT_XTIM -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 JHI/Time-HiRes-1.9739.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 21514, starting the watchdog process... # The watchdog process 21515 launched, continuing testing... # I am the watchdog process 21515, sleeping for 360 seconds... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.300258 # Select returned! 4 0.300312 # 0.899896 # Tick! 3 0.600814 # Select returned! 3 0.600857 # 0.799714333333333 # Tick! 2 0.901039 # Select returned! 2 0.901081 # 0.699639666666667 # Tick! 1 1.201249 # Select returned! 1 1.2013 # 0.599566666666667 # Tick! 0 1.501441 # Select returned! 0 1.501481 # 0.499506333333333 # ok 2 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1467277611.84002, t0 = 1467277611.83995, dt = 6.38961791992188e-05 # N = 2048, t1 = 1467277611.84017, t0 = 1467277611.84004, dt = 0.000123977661132812 # N = 4096, t1 = 1467277611.84045, t0 = 1467277611.84018, dt = 0.000273942947387695 # N = 8192, t1 = 1467277611.84097, t0 = 1467277611.84047, dt = 0.000492095947265625 # N = 16384, t1 = 1467277611.84197, t0 = 1467277611.84097, dt = 0.000995159149169922 # N = 32768, t1 = 1467277611.84553, t0 = 1467277611.84199, dt = 0.00354099273681641 # N = 65536, t1 = 1467277611.84965, t0 = 1467277611.84556, dt = 0.00408506393432617 # N = 131072, t1 = 1467277611.85805, t0 = 1467277611.84968, dt = 0.00836706161499023 # N = 262144, t1 = 1467277611.87476, t0 = 1467277611.85824, dt = 0.0165212154388428 # Alarm 1 - 1467277611.88504 # Alarm 2 - 1467277611.91878 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 21514, terminating the watchdog process 21515 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 21515 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 21516, starting the watchdog process... # The watchdog process 21517 launched, continuing testing... # I am the watchdog process 21517, 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 = 1467277617.69972, t0 = 1467277616.19929 # dt = 1.50043368339539, rt = 0.000289122263590569 ok 2 ok 3 ok 4 # clock = 0.06 # clock = 0.06 0.12 # clock = 0.06 0.12 0.19 # clock = 0.06 0.12 0.19 0.25 ok 5 # I am the main process 21516, terminating the watchdog process 21517 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 21517 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 21518, starting the watchdog process... # The watchdog process 21519 launched, continuing testing... # gettimeofday returned 2 args # I am the watchdog process 21519, sleeping for 360 seconds... ok 1 ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 21518, terminating the watchdog process 21519 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 21519 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 21520, starting the watchdog process... # The watchdog process 21521 launched, continuing testing... # setitimer: 0 0 # I am the watchdog process 21521, sleeping for 360 seconds... ok 1 - ITIMER_VIRTUAL defined with sufficient granularity # getitimer: 0.500031 0.400025 # Tick! 2 0.505287 # Tick! 1 0.905353 # Tick! 0 1.305334 # Tick! 0 1.706091 # getitimer: 0 0 # at end, i=0 ok 2 - time left should be zero # I am the main process 21520, terminating the watchdog process 21521 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 21521 = 1 # All done. ok t/nanosleep.t ..... 1..3 # I am the main process 21522, starting the watchdog process... # The watchdog process 21523 launched, continuing testing... # I am the watchdog process 21523, sleeping for 360 seconds... ok 1 - negative time error ok 2 ok 3 # I am the main process 21522, terminating the watchdog process 21523 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 21523 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 21524, starting the watchdog process... # The watchdog process 21525 launched, continuing testing... # I am the watchdog process 21525, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1467277622.82424 ok 3 # sleep...0.500362 ok 4 # I am the main process 21524, terminating the watchdog process 21525 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 21525 = 1 # All done. ok t/stat.t .......... 1..43 # I am the main process 21526, starting the watchdog process... # The watchdog process 21527 launched, continuing testing... # I am the watchdog process 21527, 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 = 1467277623.56017 1467277623.84019 1467277624.1122 1467277624.41222 1467277624.73623 # atime = 1467277623.67618 1467277624.0082 1467277624.24021 1467277624.60423 1467277624.85624 # 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 21526, terminating the watchdog process 21527 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 21527 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 21528, starting the watchdog process... # The watchdog process 21529 launched, continuing testing... # I am the watchdog process 21529, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 # s = 90.7147359848022, n = 100, s/n = 0.907147359848022 # I am the main process 21528, terminating the watchdog process 21529 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 21529 = 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 21531, starting the watchdog process... # I am the watchdog process 21532, sleeping for 360 seconds... # The watchdog process 21532 launched, continuing testing... ok 1 # tick = 1, one = 1467277624, two = 1467277625, three = 1467277625 ok 2 # tick = 3, one = 1467277624, two = 1467277625, three = 1467277625 ok 3 - negative time error # t0 = 1467277625.05208 # ualarm(100000) # t1 = 1467277625.15215 # dt = 0.100073099136353 # r = 1.00073099136353 ok 4 # t0 = 1467277625.15234 # ualarm(1100000) # t1 = 1467277626.2525 # dt = 1.10016012191772 # r = 1.00014556537975 ok 5 # t0 = 1467277626.25273 # ualarm(2200000) # t1 = 1467277628.45283 # dt = 2.20009803771973 # r = 1.00004456259988 ok 6 # t0 = 1467277628.45317 # ualarm(4300000) # t1 = 1467277632.75329 # dt = 4.30011796951294 # r = 1.00002743477045 ok 7 # t0 = 1467277632.75369 # got0 = 0 # t1 = 1467277633.05369 # t1 - t0 = 0.300000905990601 # got1 = 200007 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 21531, terminating the watchdog process 21532 before it terminates me in 351 seconds (testing took 9 seconds). # kill KILL 21532 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 21533, starting the watchdog process... # The watchdog process 21534 launched, continuing testing... # I am the watchdog process 21534, sleeping for 360 seconds... ok 1 - negative time error ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 21533, terminating the watchdog process 21534 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 21534 = 1 # All done. ok t/utime.t ......... 1..18 # I am the main process 21535, starting the watchdog process... # The watchdog process 21536 launched, continuing testing... # I am the watchdog process 21536, sleeping for 360 seconds... # utime $fh ok 1 - One file changed ok 2 - atime set correctly ok 3 - mtime set correctly #utime $filename ok 4 - One file changed ok 5 - atime set correctly ok 6 - mtime set correctly utime $filename and $fh ok 7 - Two files changed ok 8 - File 1 atime set correctly ok 9 - File 1 mtime set correctly ok 10 - File 2 atime set correctly ok 11 - File 2 mtime set correctly # utime undef sets time to now ok 12 - Two files changed ok 13 - File 1 atime set correctly ok 14 - File 1 mtime set correctly ok 15 - File 2 atime set correctly ok 16 - File 2 mtime set correctly # negative atime dies ok 17 - negative time error # negative mtime dies; ok 18 - negative time error # I am the main process 21535, terminating the watchdog process 21536 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 21536 = 1 # All done. ok All tests successful. Files=12, Tests=113, 27 wallclock secs ( 0.10 usr 0.02 sys + 14.68 cusr 0.09 csys = 14.89 CPU) Result: PASS JHI/Time-HiRes-1.9739.tar.gz make test TEST_VERBOSE=1 -- OK Fetching with LWP: http://ppm.activestate.com/CPAN/authors/id/J/JH/JHI/CHECKSUMS Jarkko Hietaniemi <jhi@iki.fi> High resolution alarm, sleep, gettimeofday, interval timers >>> (cd /data/fly2200/cpanfly-5.22/var/tmp/cpan_build/Time-HiRes-1.9739-pepQgh && tar cvf - Time-HiRes-1.9739.ppd blib) | gzip -c >/data/fly2200/cpanfly-5.22/var/REPO/J/JH/JHI/Time-HiRes-1.9739.tar.gz Time-HiRes-1.9739.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 VmSize: 339524 kB Finished 2016-06-30T02:07:17