PATH=/usr/bin:/bin:/data/fly2200/cpanfly-5.22/var/megalib/bin Start 2018-01-13T00:07:55 ActivePerl-2200 CPAN-2.10 Reading '/data/fly2200/cpanfly-5.22/var/cpan/Metadata' Database was generated on Fri, 12 Jan 2018 05:54:55 GMT Checksum for /data/fly2200/cpanfly-5.22/var/cpan/sources/authors/id/J/JH/JHI/Time-HiRes-1.9753.tar.gz ok Time-HiRes-1.9753/ Time-HiRes-1.9753/HiRes.xs Time-HiRes-1.9753/fallback/ Time-HiRes-1.9753/Changes Time-HiRes-1.9753/HiRes.pm Time-HiRes-1.9753/MANIFEST Time-HiRes-1.9753/ppport.h Time-HiRes-1.9753/t/ Time-HiRes-1.9753/README Time-HiRes-1.9753/TODO Time-HiRes-1.9753/typemap Time-HiRes-1.9753/META.yml Time-HiRes-1.9753/Makefile.PL Time-HiRes-1.9753/hints/ Time-HiRes-1.9753/META.json Time-HiRes-1.9753/hints/dynixptx.pl Time-HiRes-1.9753/hints/sco.pl Time-HiRes-1.9753/hints/svr4.pl Time-HiRes-1.9753/hints/dec_osf.pl Time-HiRes-1.9753/hints/solaris.pl Time-HiRes-1.9753/hints/aix.pl Time-HiRes-1.9753/hints/linux.pl Time-HiRes-1.9753/hints/irix.pl Time-HiRes-1.9753/t/utime.t Time-HiRes-1.9753/t/time.t Time-HiRes-1.9753/t/sleep.t Time-HiRes-1.9753/t/tv_interval.t Time-HiRes-1.9753/t/itimer.t Time-HiRes-1.9753/t/Watchdog.pm Time-HiRes-1.9753/t/alarm.t Time-HiRes-1.9753/t/stat.t Time-HiRes-1.9753/t/nanosleep.t Time-HiRes-1.9753/t/gettimeofday.t Time-HiRes-1.9753/t/usleep.t Time-HiRes-1.9753/t/clock.t Time-HiRes-1.9753/t/ualarm.t Time-HiRes-1.9753/fallback/const-c.inc Time-HiRes-1.9753/fallback/const-xs.inc Configuring J/JH/JHI/Time-HiRes-1.9753.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.9753.tar.gz /data/fly2200/ap2200-299134/bin/perl-static Makefile.PL -- OK Running make for J/JH/JHI/Time-HiRes-1.9753.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.9753\" -DXS_VERSION=\"1.9753\" -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.9753.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 22831, starting the watchdog process... # The watchdog process 22832 launched, continuing testing... # I am the watchdog process 22832, sleeping for 360 seconds... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.304174 # Select returned! 4 0.304283 # 0.898572333333333 # Tick! 3 0.604823 # Select returned! 3 0.604892 # 0.798369333333333 # Tick! 2 0.905744 # Select returned! 2 0.905783 # 0.698072333333333 # Tick! 1 1.206325 # Select returned! 1 1.206358 # 0.597880666666667 # Tick! 0 1.507217 # Select returned! 0 1.507249 # 0.497583666666667 # ok 2 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1515830885.01212, t0 = 1515830885.01205, dt = 6.4849853515625e-05 # N = 2048, t1 = 1515830885.01227, t0 = 1515830885.01214, dt = 0.000138044357299805 # N = 4096, t1 = 1515830885.01254, t0 = 1515830885.01229, dt = 0.000249147415161133 # N = 8192, t1 = 1515830885.01304, t0 = 1515830885.01254, dt = 0.000498056411743164 # N = 16384, t1 = 1515830885.01405, t0 = 1515830885.01305, dt = 0.00100111961364746 # N = 32768, t1 = 1515830885.01608, t0 = 1515830885.01407, dt = 0.00201892852783203 # N = 65536, t1 = 1515830885.02149, t0 = 1515830885.0161, dt = 0.00538396835327148 # N = 131072, t1 = 1515830885.02969, t0 = 1515830885.02151, dt = 0.00817608833312988 # N = 262144, t1 = 1515830885.0439, t0 = 1515830885.02972, dt = 0.0141761302947998 # Alarm 1 - 1515830885.05881 # Alarm 2 - 1515830885.09247 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 22831, terminating the watchdog process 22832 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 22832 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 22833, starting the watchdog process... # The watchdog process 22834 launched, continuing testing... # I am the watchdog process 22834, 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 = 1515830890.82407, t0 = 1515830889.32371 # dt = 1.50036096572876, rt = 0.000240643819173103 ok 2 ok 3 ok 4 # CLOCKS_PER_SEC = 1000000 # delay = 1000000 # clock = 0.02 # clock = 0.02 0.08 # clock = 0.02 0.08 0.16 # clock = 0.02 0.08 0.16 0.21 ok 5 # I am the main process 22833, terminating the watchdog process 22834 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 22834 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 22835, starting the watchdog process... # The watchdog process 22836 launched, continuing testing... # gettimeofday returned 2 args ok 1 ok 2 # I am the watchdog process 22836, sleeping for 360 seconds... ok 3 ok 4 ok 5 ok 6 # I am the main process 22835, terminating the watchdog process 22836 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 22836 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 22837, starting the watchdog process... # The watchdog process 22838 launched, continuing testing... # setitimer: 0 0 # I am the watchdog process 22838, sleeping for 360 seconds... ok 1 - ITIMER_VIRTUAL defined with sufficient granularity # getitimer: 0.504031 0.400025 # Tick! 2 0.780174 # Tick! 1 1.370395 # Tick! 0 1.990374 # Tick! 0 2.620153 # getitimer: 0 0 # at end, i=0 ok 2 - time left should be zero # I am the main process 22837, terminating the watchdog process 22838 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 22838 = 1 # All done. ok t/nanosleep.t ..... 1..4 # I am the main process 22839, starting the watchdog process... # The watchdog process 22840 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 22840, sleeping for 360 seconds... ok 2 ok 3 - nanosleep for more than 0.4 sec ok 4 # I am the main process 22839, terminating the watchdog process 22840 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 22840 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 22841, starting the watchdog process... # The watchdog process 22842 launched, continuing testing... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1515830896.82553 ok 3 # I am the watchdog process 22842, sleeping for 360 seconds... # sleep...0.500209 ok 4 # I am the main process 22841, terminating the watchdog process 22842 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 22842 = 1 # All done. ok t/stat.t .......... 1..43 # I am the main process 22843, starting the watchdog process... # The watchdog process 22844 launched, continuing testing... # I am the watchdog process 22844, 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 = 1515830897.48524 1515830897.79323 1515830898.17324 1515830898.46124 1515830898.80524 # atime = 1515830897.62125 1515830897.97724 1515830898.30523 1515830898.64924 1515830898.93724 # 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 22843, terminating the watchdog process 22844 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 22844 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 22845, starting the watchdog process... # The watchdog process 22846 launched, continuing testing... ok 1 - require Time::HiRes; ok 2 # s = 98.3545391559601, n = 100, s/n = 0.983545391559601 # I am the main process 22845, terminating the watchdog process 22846 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 22846 = 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 22848, starting the watchdog process... # The watchdog process 22849 launched, continuing testing... # I am the watchdog process 22849, sleeping for 360 seconds... ok 1 # tick = 1, one = 1515830899, two = 1515830899, three = 1515830899 ok 2 # tick = 3, one = 1515830899, two = 1515830899, three = 1515830899 ok 3 - negative time error # t0 = 1515830899.13952 # ualarm(100000) # t1 = 1515830899.249 # dt = 0.109479904174805 # r = 1.09479904174805 ok 4 # t0 = 1515830899.2492 # ualarm(1100000) # t1 = 1515830900.359 # dt = 1.10980319976807 # r = 1.00891199978915 ok 5 # t0 = 1515830900.35929 # ualarm(2200000) # t1 = 1515830902.5648 # dt = 2.20550990104675 # r = 1.0025045004758 ok 6 # t0 = 1515830902.56509 # ualarm(4300000) # t1 = 1515830906.86902 # dt = 4.30393314361572 # r = 1.0009146845618 ok 7 # t0 = 1515830906.86934 # got0 = 0 # t1 = 1515830907.16934 # t1 - t0 = 0.300000905990601 # got1 = 199999 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 22848, terminating the watchdog process 22849 before it terminates me in 352 seconds (testing took 8 seconds). # kill KILL 22849 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 22850, starting the watchdog process... # The watchdog process 22851 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 22851, sleeping for 360 seconds... ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 22850, terminating the watchdog process 22851 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 22851 = 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.9753-l8_TNp # Subsecond file timestamps in /data/fly2200/cpanfly-5.22/var/tmp/cpan_build/Time-HiRes-1.9753-l8_TNp: OK 1..18 # I am the main process 22852, starting the watchdog process... # The watchdog process 22853 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 # I am the watchdog process 22853, sleeping for 360 seconds... 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 22852, terminating the watchdog process 22853 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 22853 = 1 # All done. ok All tests successful. Files=12, Tests=114, 29 wallclock secs ( 0.06 usr 0.04 sys + 15.30 cusr 0.23 csys = 15.63 CPU) Result: PASS JHI/Time-HiRes-1.9753.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.9753-l8_TNp && tar cvf - Time-HiRes-1.9753.ppd blib) | gzip -c >/data/fly2200/cpanfly-5.22/var/REPO/J/JH/JHI/Time-HiRes-1.9753.tar.gz Time-HiRes-1.9753.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: 365180 kB Finished 2018-01-13T00:08:33