PATH=/usr/bin:/bin:/data/fly2200/cpanfly-5.22/var/megalib/bin Start 2018-01-04T00:19:55 ActivePerl-2200 CPAN-2.10 Reading '/data/fly2200/cpanfly-5.22/var/cpan/Metadata' Database was generated on Wed, 03 Jan 2018 05:53:54 GMT Checksum for /data/fly2200/cpanfly-5.22/var/cpan/sources/authors/id/J/JH/JHI/Time-HiRes-1.9751.tar.gz ok Time-HiRes-1.9751/ Time-HiRes-1.9751/HiRes.xs Time-HiRes-1.9751/fallback/ Time-HiRes-1.9751/Changes Time-HiRes-1.9751/HiRes.pm Time-HiRes-1.9751/MANIFEST Time-HiRes-1.9751/ppport.h Time-HiRes-1.9751/t/ Time-HiRes-1.9751/README Time-HiRes-1.9751/TODO Time-HiRes-1.9751/typemap Time-HiRes-1.9751/META.yml Time-HiRes-1.9751/Makefile.PL Time-HiRes-1.9751/hints/ Time-HiRes-1.9751/META.json Time-HiRes-1.9751/hints/dynixptx.pl Time-HiRes-1.9751/hints/sco.pl Time-HiRes-1.9751/hints/svr4.pl Time-HiRes-1.9751/hints/dec_osf.pl Time-HiRes-1.9751/hints/solaris.pl Time-HiRes-1.9751/hints/aix.pl Time-HiRes-1.9751/hints/linux.pl Time-HiRes-1.9751/hints/irix.pl Time-HiRes-1.9751/t/utime.t Time-HiRes-1.9751/t/time.t Time-HiRes-1.9751/t/sleep.t Time-HiRes-1.9751/t/tv_interval.t Time-HiRes-1.9751/t/itimer.t Time-HiRes-1.9751/t/Watchdog.pm Time-HiRes-1.9751/t/alarm.t Time-HiRes-1.9751/t/stat.t Time-HiRes-1.9751/t/nanosleep.t Time-HiRes-1.9751/t/gettimeofday.t Time-HiRes-1.9751/t/usleep.t Time-HiRes-1.9751/t/clock.t Time-HiRes-1.9751/t/ualarm.t Time-HiRes-1.9751/fallback/const-c.inc Time-HiRes-1.9751/fallback/const-xs.inc Configuring J/JH/JHI/Time-HiRes-1.9751.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 clockid_t... found. Looking for clock_gettime()... found. Looking for clock_getres()... found. Looking for clock_nanosleep()... found. Looking for clock()... found. Looking for working futimens()... found. Looking for working utimensat()... found. You seem to have subsecond timestamp setting. 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 subsecond timestamp reading. (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.9751.tar.gz /data/fly2200/ap2200-299134/bin/perl-static Makefile.PL -- OK Running make for J/JH/JHI/Time-HiRes-1.9751.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.9751\" -DXS_VERSION=\"1.9751\" -fPIC "-I/home/fly2200/ap2200-299134/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 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.9751.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 23668, starting the watchdog process... # The watchdog process 23669 launched, continuing testing... # I am the watchdog process 23669, sleeping for 360 seconds... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.300616 # Select returned! 4 0.300711 # 0.899763 # Tick! 3 0.603169 # Select returned! 3 0.603209 # 0.798930333333333 # Tick! 2 0.903487 # Select returned! 2 0.903522 # 0.698826 # Tick! 1 1.203781 # Select returned! 1 1.20382 # 0.598726666666667 # Tick! 0 1.504296 # Select returned! 0 1.504331 # 0.498556333333333 # ok 2 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1515054004.70486, t0 = 1515054004.7048, dt = 6.69956207275391e-05 # N = 2048, t1 = 1515054004.70503, t0 = 1515054004.70489, dt = 0.000143051147460938 # N = 4096, t1 = 1515054004.70532, t0 = 1515054004.70504, dt = 0.000274896621704102 # N = 8192, t1 = 1515054004.70585, t0 = 1515054004.70533, dt = 0.000516891479492188 # N = 16384, t1 = 1515054004.70688, t0 = 1515054004.70586, dt = 0.00101900100708008 # N = 32768, t1 = 1515054004.70892, t0 = 1515054004.70688, dt = 0.00203204154968262 # N = 65536, t1 = 1515054004.7142, t0 = 1515054004.70893, dt = 0.0052790641784668 # N = 131072, t1 = 1515054004.72271, t0 = 1515054004.71423, dt = 0.00848197937011719 # N = 262144, t1 = 1515054004.73954, t0 = 1515054004.72273, dt = 0.0168049335479736 # Alarm 1 - 1515054004.75104 # Alarm 2 - 1515054004.7907 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 23668, terminating the watchdog process 23669 before it terminates me in 355 seconds (testing took 5 seconds). # kill KILL 23669 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 23670, starting the watchdog process... # The watchdog process 23671 launched, continuing testing... # I am the watchdog process 23671, 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 = 1515054010.52788, t0 = 1515054009.02588 # dt = 1.50200033187866, rt = 0.00133355458577467 ok 2 ok 3 ok 4 # clock = 0.03 # clock = 0.03 0.09 # clock = 0.03 0.09 0.15 # clock = 0.03 0.09 0.15 0.2 ok 5 # I am the main process 23670, terminating the watchdog process 23671 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 23671 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 23672, starting the watchdog process... # The watchdog process 23673 launched, continuing testing... # gettimeofday returned 2 args ok 1 # I am the watchdog process 23673, sleeping for 360 seconds... ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 23672, terminating the watchdog process 23673 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 23673 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 23674, starting the watchdog process... # The watchdog process 23675 launched, continuing testing... # setitimer: 0 0 ok 1 - ITIMER_VIRTUAL defined with sufficient granularity # I am the watchdog process 23675, sleeping for 360 seconds... # getitimer: 0.504031 0.400025 # Tick! 2 0.802202 # Tick! 1 1.44341 # Tick! 0 2.0732 # Tick! 0 2.723393 # getitimer: 0 0 # at end, i=0 ok 2 - time left should be zero # I am the main process 23674, terminating the watchdog process 23675 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 23675 = 1 # All done. ok t/nanosleep.t ..... 1..4 # I am the main process 23676, starting the watchdog process... # The watchdog process 23677 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 23677, sleeping for 360 seconds... ok 2 ok 3 - nanosleep for more than 0.4 sec ok 4 # I am the main process 23676, terminating the watchdog process 23677 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 23677 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 23678, starting the watchdog process... # The watchdog process 23679 launched, continuing testing... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1515054016.6305 ok 3 # I am the watchdog process 23679, sleeping for 360 seconds... # sleep...0.500387 ok 4 # I am the main process 23678, terminating the watchdog process 23679 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 23679 = 1 # All done. ok t/stat.t .......... 1..43 # I am the main process 23680, starting the watchdog process... # The watchdog process 23681 launched, continuing testing... # I am the watchdog process 23681, 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 = 1515054017.28105 1515054017.62105 1515054017.90505 1515054018.21705 1515054018.47705 # atime = 1515054017.46105 1515054017.78506 1515054018.09306 1515054018.36905 1515054018.58906 # 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 23680, terminating the watchdog process 23681 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 23681 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 23682, starting the watchdog process... # The watchdog process 23683 launched, continuing testing... # I am the watchdog process 23683, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 # s = 63.9386713504791, n = 100, s/n = 0.639386713504791 # I am the main process 23682, terminating the watchdog process 23683 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 23683 = 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 23685, starting the watchdog process... # The watchdog process 23686 launched, continuing testing... # I am the watchdog process 23686, sleeping for 360 seconds... ok 1 # tick = 1, one = 1515054018, two = 1515054018, three = 1515054018 ok 2 # tick = 3, one = 1515054018, two = 1515054018, three = 1515054018 ok 3 - negative time error # t0 = 1515054018.78154 # ualarm(100000) # t1 = 1515054018.89119 # dt = 0.10964298248291 # r = 1.0964298248291 ok 4 # t0 = 1515054018.89139 # ualarm(1100000) # t1 = 1515054019.9918 # dt = 1.10040903091431 # r = 1.00037184628573 ok 5 # t0 = 1515054019.99214 # ualarm(2200000) # t1 = 1515054022.20124 # dt = 2.20910406112671 # r = 1.00413820960305 ok 6 # t0 = 1515054022.20168 # ualarm(4300000) # t1 = 1515054026.51124 # dt = 4.30956721305847 # r = 1.00222493326941 ok 7 # t0 = 1515054026.51167 # got0 = 0 # t1 = 1515054026.81169 # t1 - t0 = 0.300026893615723 # got1 = 199940 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 23685, terminating the watchdog process 23686 before it terminates me in 352 seconds (testing took 8 seconds). # kill KILL 23686 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 23687, starting the watchdog process... # The watchdog process 23688 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 23688, sleeping for 360 seconds... ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 23687, terminating the watchdog process 23688 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 23688 = 1 # All done. ok t/utime.t ......... # Testing for subsecond file timestamps (mtime) in /data/fly2200/cpanfly-5.22/var/tmp/cpan_build/Time-HiRes-1.9751-6IhfFv # Subsecond file timestamps in /data/fly2200/cpanfly-5.22/var/tmp/cpan_build/Time-HiRes-1.9751-6IhfFv: OK 1..18 # I am the main process 23689, starting the watchdog process... # The watchdog process 23690 launched, continuing testing... # $^O = linux, atime = 1.111111111, mtime = 2.222222222 # utime $fh # I am the watchdog process 23690, sleeping for 360 seconds... 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 23689, terminating the watchdog process 23690 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 23690 = 1 # All done. ok All tests successful. Files=12, Tests=114, 29 wallclock secs ( 0.08 usr 0.03 sys + 15.32 cusr 0.31 csys = 15.74 CPU) Result: PASS JHI/Time-HiRes-1.9751.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.9751-6IhfFv && tar cvf - Time-HiRes-1.9751.ppd blib) | gzip -c >/data/fly2200/cpanfly-5.22/var/REPO/J/JH/JHI/Time-HiRes-1.9751.tar.gz Time-HiRes-1.9751.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: 365004 kB Finished 2018-01-04T00:20:32