PATH=/usr/bin:/bin:/data/fly2400/cpanfly-5.24/var/megalib/bin Start 2017-07-28T04:12:07 ActivePerl-2400 CPAN-2.10 Reading '/data/fly2400/cpanfly-5.24/var/cpan/Metadata' Database was generated on Fri, 28 Jul 2017 04:41:02 GMT Fetching with LWP: http://ppm.activestate.com/CPAN/authors/id/J/JH/JHI/Time-HiRes-1.9744.tar.gz Fetching with LWP: http://ppm.activestate.com/CPAN/authors/id/J/JH/JHI/CHECKSUMS Checksum for /data/fly2400/cpanfly-5.24/var/cpan/sources/authors/id/J/JH/JHI/Time-HiRes-1.9744.tar.gz ok Time-HiRes-1.9744/ Time-HiRes-1.9744/Changes Time-HiRes-1.9744/fallback/ Time-HiRes-1.9744/hints/ Time-HiRes-1.9744/HiRes.pm Time-HiRes-1.9744/HiRes.xs Time-HiRes-1.9744/Makefile.PL Time-HiRes-1.9744/MANIFEST Time-HiRes-1.9744/META.json Time-HiRes-1.9744/META.yml Time-HiRes-1.9744/ppport.h Time-HiRes-1.9744/README Time-HiRes-1.9744/t/ Time-HiRes-1.9744/TODO Time-HiRes-1.9744/typemap Time-HiRes-1.9744/t/alarm.t Time-HiRes-1.9744/t/clock.t Time-HiRes-1.9744/t/gettimeofday.t Time-HiRes-1.9744/t/itimer.t Time-HiRes-1.9744/t/nanosleep.t Time-HiRes-1.9744/t/sleep.t Time-HiRes-1.9744/t/stat.t Time-HiRes-1.9744/t/time.t Time-HiRes-1.9744/t/tv_interval.t Time-HiRes-1.9744/t/ualarm.t Time-HiRes-1.9744/t/usleep.t Time-HiRes-1.9744/t/utime.t Time-HiRes-1.9744/t/Watchdog.pm Time-HiRes-1.9744/hints/aix.pl Time-HiRes-1.9744/hints/dec_osf.pl Time-HiRes-1.9744/hints/dynixptx.pl Time-HiRes-1.9744/hints/irix.pl Time-HiRes-1.9744/hints/linux.pl Time-HiRes-1.9744/hints/sco.pl Time-HiRes-1.9744/hints/solaris.pl Time-HiRes-1.9744/hints/svr4.pl Time-HiRes-1.9744/fallback/const-c.inc Time-HiRes-1.9744/fallback/const-xs.inc Configuring J/JH/JHI/Time-HiRes-1.9744.tar.gz with Makefile.PL >>> /data/fly2400/ap2400-300558/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 clockid_t... found. 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...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/fly2400/cpanfly-5.24/var/megalib Want /home/fly2400/ap2400-300558/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.9744.tar.gz /data/fly2400/ap2400-300558/bin/perl-static Makefile.PL -- OK Running make for J/JH/JHI/Time-HiRes-1.9744.tar.gz >>> make cp HiRes.pm blib/lib/Time/HiRes.pm Running Mkbootstrap for HiRes () chmod 644 "HiRes.bs" "/data/fly2400/ap2400-300558/bin/perl-static" -MExtUtils::Command::MM -e 'cp_nonempty' -- HiRes.bs blib/arch/auto/Time/HiRes/HiRes.bs 644 "/data/fly2400/ap2400-300558/bin/perl-static" "/data/fly2400/cpanfly-5.24/var/megalib/ExtUtils/xsubpp" -typemap '/home/fly2400/ap2400-300558/lib/ExtUtils/typemap' -typemap '/data/fly2400/cpanfly-5.24/var/tmp/cpan_build/Time-HiRes-1.9744-j8HfOu/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.9744\" -DXS_VERSION=\"1.9744\" -fPIC "-I/home/fly2400/ap2400-300558/lib/CORE" -DTIME_HIRES_NANOSLEEP -DTIME_HIRES_CLOCKID_T -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 -o blib/arch/auto/Time/HiRes/HiRes.so HiRes.o \ -lrt \ chmod 755 blib/arch/auto/Time/HiRes/HiRes.so Manifying 1 pod document JHI/Time-HiRes-1.9744.tar.gz make -- OK Running make test >>> make test TEST_VERBOSE=1 "/data/fly2400/ap2400-300558/bin/perl-static" -MExtUtils::Command::MM -e 'cp_nonempty' -- HiRes.bs blib/arch/auto/Time/HiRes/HiRes.bs 644 PERL_DL_NONLAZY=1 "/data/fly2400/ap2400-300558/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 22728, starting the watchdog process... # The watchdog process 22729 launched, continuing testing... # I am the watchdog process 22729, sleeping for 360 seconds... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.300602 # Select returned! 4 0.300659 # 0.899780333333333 # Tick! 3 0.600793 # Select returned! 3 0.600835 # 0.799721666666667 # Tick! 2 0.90096 # Select returned! 2 0.900993 # 0.699669 # Tick! 1 1.20112 # Select returned! 1 1.201155 # 0.599615 # Tick! 0 1.501299 # Select returned! 0 1.501332 # 0.499556 # ok 2 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1501240337.78469, t0 = 1501240337.78461, dt = 8.29696655273438e-05 # N = 2048, t1 = 1501240337.78488, t0 = 1501240337.78472, dt = 0.00016021728515625 # N = 4096, t1 = 1501240337.78522, t0 = 1501240337.78488, dt = 0.000332117080688477 # N = 8192, t1 = 1501240337.78586, t0 = 1501240337.78523, dt = 0.000636816024780273 # N = 16384, t1 = 1501240337.78783, t0 = 1501240337.78587, dt = 0.00195884704589844 # N = 32768, t1 = 1501240337.79055, t0 = 1501240337.78785, dt = 0.00269603729248047 # N = 65536, t1 = 1501240337.79626, t0 = 1501240337.79056, dt = 0.00570011138916016 # N = 131072, t1 = 1501240337.8057, t0 = 1501240337.79628, dt = 0.00941681861877441 # N = 262144, t1 = 1501240337.8265, t0 = 1501240337.80612, dt = 0.0203850269317627 # Alarm 1 - 1501240337.84174 # Alarm 2 - 1501240337.88332 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 22728, terminating the watchdog process 22729 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 22729 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 22730, starting the watchdog process... # The watchdog process 22731 launched, continuing testing... ok 1 - require Time::HiRes; # have_clock_gettime = 1 # have_clock_getres = 1 # have_clock_nanosleep = 1 # have_clock = 1 # CLOCK_REALTIME: try = 1 # I am the watchdog process 22731, sleeping for 360 seconds... # t1 = 1501240343.69945, t0 = 1501240342.19919 # dt = 1.50025653839111, rt = 0.000171025594075447 ok 2 ok 3 ok 4 # clock = 0.06 # clock = 0.06 0.12 # clock = 0.06 0.12 0.17 # clock = 0.06 0.12 0.17 0.22 ok 5 # I am the main process 22730, terminating the watchdog process 22731 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 22731 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 22732, starting the watchdog process... # The watchdog process 22733 launched, continuing testing... # gettimeofday returned 2 args ok 1 ok 2 # I am the watchdog process 22733, sleeping for 360 seconds... ok 3 ok 4 ok 5 ok 6 # I am the main process 22732, terminating the watchdog process 22733 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 22733 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 22734, starting the watchdog process... # The watchdog process 22735 launched, continuing testing... # setitimer: 0 0 ok 1 - ITIMER_VIRTUAL defined with sufficient granularity # getitimer: 0.504031 0.400025 # I am the watchdog process 22735, sleeping for 360 seconds... # Tick! 2 0.786687 # Tick! 1 1.389544 # Tick! 0 2.026664 # Tick! 0 2.646663 # getitimer: 0 0 # at end, i=0 ok 2 - time left should be zero # I am the main process 22734, terminating the watchdog process 22735 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 22735 = 1 # All done. ok t/nanosleep.t ..... 1..3 # I am the main process 22736, starting the watchdog process... # The watchdog process 22737 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 22737, sleeping for 360 seconds... ok 2 ok 3 # I am the main process 22736, terminating the watchdog process 22737 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 22737 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 22738, starting the watchdog process... # The watchdog process 22739 launched, continuing testing... ok 1 - require Time::HiRes; # I am the watchdog process 22739, sleeping for 360 seconds... ok 2 - negative time error # time...1501240349.85149 ok 3 # sleep...0.500125 ok 4 # I am the main process 22738, terminating the watchdog process 22739 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 22739 = 1 # All done. ok t/stat.t .......... 1..43 # I am the main process 22740, starting the watchdog process... # The watchdog process 22741 launched, continuing testing... # I am the watchdog process 22741, 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 = 1501240350.56412 1501240350.87211 1501240351.19212 1501240351.54012 1501240351.88012 # atime = 1501240350.68012 1501240351.00812 1501240351.36412 1501240351.73612 1501240352.05212 # 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 22740, terminating the watchdog process 22741 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 22741 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 22742, starting the watchdog process... # The watchdog process 22743 launched, continuing testing... ok 1 - require Time::HiRes; # I am the watchdog process 22743, sleeping for 360 seconds... ok 2 # s = 13.4430108070374, n = 100, s/n = 0.134430108070374 # I am the main process 22742, terminating the watchdog process 22743 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 22743 = 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 22745, starting the watchdog process... # The watchdog process 22746 launched, continuing testing... # I am the watchdog process 22746, sleeping for 360 seconds... ok 1 # tick = 1, one = 1501240352, two = 1501240352, three = 1501240352 ok 2 # tick = 3, one = 1501240352, two = 1501240352, three = 1501240352 ok 3 - negative time error # t0 = 1501240352.35291 # ualarm(100000) # t1 = 1501240352.46226 # dt = 0.10935115814209 # r = 1.0935115814209 ok 4 # t0 = 1501240352.46245 # ualarm(1100000) # t1 = 1501240353.57226 # dt = 1.10980916023254 # r = 1.00891741839322 ok 5 # t0 = 1501240353.57253 # ualarm(2200000) # t1 = 1501240355.77393 # dt = 2.2014000415802 # r = 1.00063638253645 ok 6 # t0 = 1501240355.77453 # ualarm(4300000) # t1 = 1501240360.08229 # dt = 4.30775713920593 # r = 1.00180398586184 ok 7 # t0 = 1501240360.08265 # got0 = 0 # t1 = 1501240360.38265 # t1 - t0 = 0.300000905990601 # got1 = 200003 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 22745, terminating the watchdog process 22746 before it terminates me in 352 seconds (testing took 8 seconds). # kill KILL 22746 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 22747, starting the watchdog process... # The watchdog process 22748 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 22748, sleeping for 360 seconds... ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 22747, terminating the watchdog process 22748 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 22748 = 1 # All done. ok t/utime.t ......... # fstype = ext4 1..18 # I am the main process 22749, starting the watchdog process... # The watchdog process 22751 launched, continuing testing... # $^O = linux, atime = 1.111111111, mtime = 2.222222222 # 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 22749, terminating the watchdog process 22751 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 22751 = 1 # All done. ok All tests successful. Files=12, Tests=113, 28 wallclock secs ( 0.09 usr 0.01 sys + 15.70 cusr 0.25 csys = 16.05 CPU) Result: PASS JHI/Time-HiRes-1.9744.tar.gz make test TEST_VERBOSE=1 -- OK Jarkko Hietaniemi <jhi@iki.fi> High resolution alarm, sleep, gettimeofday, interval timers >>> (cd /data/fly2400/cpanfly-5.24/var/tmp/cpan_build/Time-HiRes-1.9744-j8HfOu && tar cvf - Time-HiRes-1.9744.ppd blib) | gzip -c >/data/fly2400/cpanfly-5.24/var/REPO/J/JH/JHI/Time-HiRes-1.9744.tar.gz Time-HiRes-1.9744.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: 356512 kB Finished 2017-07-28T04:12:44