PATH=/usr/bin:/bin:/data/fly2200/cpanfly-5.22/var/megalib/bin Start 2018-03-17T00:15:53 ActivePerl-2200 CPAN-2.10 Reading '/data/fly2200/cpanfly-5.22/var/cpan/Metadata' Database was generated on Fri, 16 Mar 2018 03:17:02 GMT Checksum for /data/fly2200/cpanfly-5.22/var/cpan/sources/authors/id/J/JH/JHI/Time-HiRes-1.9757.tar.gz ok Time-HiRes-1.9757/ Time-HiRes-1.9757/HiRes.xs Time-HiRes-1.9757/fallback/ Time-HiRes-1.9757/Changes Time-HiRes-1.9757/HiRes.pm Time-HiRes-1.9757/MANIFEST Time-HiRes-1.9757/ppport.h Time-HiRes-1.9757/t/ Time-HiRes-1.9757/README Time-HiRes-1.9757/TODO Time-HiRes-1.9757/typemap Time-HiRes-1.9757/META.yml Time-HiRes-1.9757/Makefile.PL Time-HiRes-1.9757/hints/ Time-HiRes-1.9757/META.json Time-HiRes-1.9757/hints/dynixptx.pl Time-HiRes-1.9757/hints/sco.pl Time-HiRes-1.9757/hints/svr4.pl Time-HiRes-1.9757/hints/dec_osf.pl Time-HiRes-1.9757/hints/solaris.pl Time-HiRes-1.9757/hints/aix.pl Time-HiRes-1.9757/hints/linux.pl Time-HiRes-1.9757/hints/irix.pl Time-HiRes-1.9757/t/utime.t Time-HiRes-1.9757/t/time.t Time-HiRes-1.9757/t/sleep.t Time-HiRes-1.9757/t/tv_interval.t Time-HiRes-1.9757/t/itimer.t Time-HiRes-1.9757/t/Watchdog.pm Time-HiRes-1.9757/t/alarm.t Time-HiRes-1.9757/t/stat.t Time-HiRes-1.9757/t/nanosleep.t Time-HiRes-1.9757/t/gettimeofday.t Time-HiRes-1.9757/t/usleep.t Time-HiRes-1.9757/t/clock.t Time-HiRes-1.9757/t/ualarm.t Time-HiRes-1.9757/fallback/const-c.inc Time-HiRes-1.9757/fallback/const-xs.inc Configuring J/JH/JHI/Time-HiRes-1.9757.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.9757.tar.gz /data/fly2200/ap2200-299134/bin/perl-static Makefile.PL -- OK Running make for J/JH/JHI/Time-HiRes-1.9757.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.9757\" -DXS_VERSION=\"1.9757\" -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.9757.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 27189, starting the watchdog process... # The watchdog process 27190 launched, continuing testing... # I am the watchdog process 27190, sleeping for 360 seconds... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.300538 # Select returned! 4 0.300603 # 0.899799 # Tick! 3 0.601251 # Select returned! 3 0.601277 # 0.799574333333333 # Tick! 2 0.901505 # Select returned! 2 0.901532 # 0.699489333333333 # Tick! 1 1.202956 # Select returned! 1 1.202982 # 0.599006 # Tick! 0 1.50412 # Select returned! 0 1.504146 # 0.498618 # ok 2 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1521270962.79024, t0 = 1521270962.79017, dt = 6.50882720947266e-05 # N = 2048, t1 = 1521270962.79038, t0 = 1521270962.79026, dt = 0.000125885009765625 # N = 4096, t1 = 1521270962.79065, t0 = 1521270962.79039, dt = 0.000256061553955078 # N = 8192, t1 = 1521270962.79117, t0 = 1521270962.79065, dt = 0.000516891479492188 # N = 16384, t1 = 1521270962.7922, t0 = 1521270962.79118, dt = 0.00101613998413086 # N = 32768, t1 = 1521270962.79423, t0 = 1521270962.79221, dt = 0.0020289421081543 # N = 65536, t1 = 1521270962.79831, t0 = 1521270962.79424, dt = 0.00406193733215332 # N = 131072, t1 = 1521270962.80773, t0 = 1521270962.79831, dt = 0.0094149112701416 # N = 262144, t1 = 1521270962.82435, t0 = 1521270962.80775, dt = 0.0165948867797852 # Alarm 1 - 1521270962.84041 # Alarm 2 - 1521270962.87241 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 27189, terminating the watchdog process 27190 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 27190 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 27191, starting the watchdog process... # The watchdog process 27192 launched, continuing testing... # I am the watchdog process 27192, 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 = 1521270968.59612, t0 = 1521270967.09478 # dt = 1.50134038925171, rt = 0.000893592834472656 ok 2 ok 3 ok 4 # CLOCKS_PER_SEC = 1000000 # delay = 1000000 # clock = 0.03 # clock = 0.03 0.08 # clock = 0.03 0.08 0.14 # clock = 0.03 0.08 0.14 0.21 ok 5 # I am the main process 27191, terminating the watchdog process 27192 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 27192 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 27193, starting the watchdog process... # The watchdog process 27194 launched, continuing testing... # gettimeofday returned 2 args ok 1 ok 2 # I am the watchdog process 27194, sleeping for 360 seconds... ok 3 ok 4 ok 5 ok 6 # I am the main process 27193, terminating the watchdog process 27194 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 27194 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 27195, starting the watchdog process... # The watchdog process 27196 launched, continuing testing... # setitimer: 0 0 ok 1 - ITIMER_VIRTUAL defined with sufficient granularity # getitimer: 0.504031 0.400025 # I am the watchdog process 27196, sleeping for 360 seconds... # Tick! 2 0.782152 # Tick! 1 1.402412 # Tick! 0 2.012638 # Tick! 0 2.652643 # getitimer: 0 0 # at end, i=0 ok 2 - time left should be zero # I am the main process 27195, terminating the watchdog process 27196 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 27196 = 1 # All done. ok t/nanosleep.t ..... 1..4 # I am the main process 27197, starting the watchdog process... # The watchdog process 27198 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 27198, sleeping for 360 seconds... ok 2 ok 3 - nanosleep for more than 0.4 sec ok 4 # I am the main process 27197, terminating the watchdog process 27198 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 27198 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 27199, starting the watchdog process... # The watchdog process 27200 launched, continuing testing... # I am the watchdog process 27200, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1521270974.63412 ok 3 # sleep...0.500585 ok 4 # I am the main process 27199, terminating the watchdog process 27200 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 27200 = 1 # All done. ok t/stat.t .......... 1..43 # I am the main process 27201, starting the watchdog process... # The watchdog process 27202 launched, continuing testing... # I am the watchdog process 27202, 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 = 1521270975.27772 1521270975.49772 1521270975.82571 1521270976.14172 1521270976.48972 # atime = 1521270975.39372 1521270975.66572 1521270976.00571 1521270976.31372 1521270976.64972 # 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 27201, terminating the watchdog process 27202 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 27202 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 27203, starting the watchdog process... # The watchdog process 27204 launched, continuing testing... ok 1 - require Time::HiRes; # I am the watchdog process 27204, sleeping for 360 seconds... ok 2 # s = 69.9314315319061, n = 100, s/n = 0.699314315319061 # I am the main process 27203, terminating the watchdog process 27204 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 27204 = 1 # All done. ok t/tv_interval.t ... 1..13 ok 1 - require Time::HiRes; ok 2 - 10.5 - 5.1 = 5.4 ok 3 - [] - [] = 0 ok 4 - now - [1521270976 738358] = 5e-06 >= 0 ok 5 - [1521270976 738358] - [1521270976 738358] = 0 ok 6 - [1521270976 838765] - [1521270976 738358] = 0.100407 (0.100407, 1) ok 7 - at least one arg ok 8 - 1st arg aref ok 9 - 1st arg aref ok 10 - 1st arg aref ok 11 - 2nd arg aref ok 12 - 2nd arg aref ok 13 - no extra decimals ok t/ualarm.t ........ 1..12 # I am the main process 27206, starting the watchdog process... # The watchdog process 27207 launched, continuing testing... # I am the watchdog process 27207, sleeping for 360 seconds... ok 1 # tick = 1, one = 1521270976, two = 1521270976, three = 1521270976 ok 2 # tick = 3, one = 1521270976, two = 1521270976, three = 1521270976 ok 3 - negative time error # t0 = 1521270977.04098 # ualarm(100000) # t1 = 1521270977.15041 # dt = 0.109431982040405 # r = 1.09431982040405 ok 4 # t0 = 1521270977.15069 # ualarm(1100000) # t1 = 1521270978.26052 # dt = 1.10983300209045 # r = 1.0089390928095 ok 5 # t0 = 1521270978.26087 # ualarm(2200000) # t1 = 1521270980.47041 # dt = 2.20954394340515 # r = 1.00433815609325 ok 6 # t0 = 1521270980.47075 # ualarm(4300000) # t1 = 1521270984.78052 # dt = 4.30977487564087 # r = 1.00227322689323 ok 7 # t0 = 1521270984.78076 # got0 = 0 # t1 = 1521270985.08076 # t1 - t0 = 0.30000114440918 # got1 = 200000 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 27206, terminating the watchdog process 27207 before it terminates me in 351 seconds (testing took 9 seconds). # kill KILL 27207 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 27208, starting the watchdog process... # The watchdog process 27209 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 27209, sleeping for 360 seconds... ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 27208, terminating the watchdog process 27209 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 27209 = 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.9757-sYBqx0 # Subsecond file timestamps in /data/fly2200/cpanfly-5.22/var/tmp/cpan_build/Time-HiRes-1.9757-sYBqx0: OK 1..18 # I am the main process 27210, starting the watchdog process... # The watchdog process 27211 launched, continuing testing... # $^O = linux, atime = 1.111111111, mtime = 2.222222222 # utime $fh # I am the watchdog process 27211, 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 27210, terminating the watchdog process 27211 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 27211 = 1 # All done. ok All tests successful. Files=12, Tests=125, 29 wallclock secs ( 0.07 usr 0.02 sys + 15.26 cusr 0.24 csys = 15.59 CPU) Result: PASS JHI/Time-HiRes-1.9757.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.9757-sYBqx0 && tar cvf - Time-HiRes-1.9757.ppd blib) | gzip -c >/data/fly2200/cpanfly-5.22/var/REPO/J/JH/JHI/Time-HiRes-1.9757.tar.gz Time-HiRes-1.9757.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: 367088 kB Finished 2018-03-17T00:16:30