PATH=/usr/bin:/bin:/data/fly2200/cpanfly-5.22/var/megalib/bin Start 2017-12-23T00:08:43 ActivePerl-2200 CPAN-2.10 Reading '/data/fly2200/cpanfly-5.22/var/cpan/Metadata' Database was generated on Fri, 22 Dec 2017 04:17:03 GMT Checksum for /data/fly2200/cpanfly-5.22/var/cpan/sources/authors/id/J/JH/JHI/Time-HiRes-1.9749.tar.gz ok Time-HiRes-1.9749/ Time-HiRes-1.9749/HiRes.xs Time-HiRes-1.9749/fallback/ Time-HiRes-1.9749/Changes Time-HiRes-1.9749/HiRes.pm Time-HiRes-1.9749/MANIFEST Time-HiRes-1.9749/ppport.h Time-HiRes-1.9749/t/ Time-HiRes-1.9749/README Time-HiRes-1.9749/TODO Time-HiRes-1.9749/typemap Time-HiRes-1.9749/META.yml Time-HiRes-1.9749/Makefile.PL Time-HiRes-1.9749/hints/ Time-HiRes-1.9749/META.json Time-HiRes-1.9749/hints/dynixptx.pl Time-HiRes-1.9749/hints/sco.pl Time-HiRes-1.9749/hints/svr4.pl Time-HiRes-1.9749/hints/dec_osf.pl Time-HiRes-1.9749/hints/solaris.pl Time-HiRes-1.9749/hints/aix.pl Time-HiRes-1.9749/hints/linux.pl Time-HiRes-1.9749/hints/irix.pl Time-HiRes-1.9749/t/utime.t Time-HiRes-1.9749/t/time.t Time-HiRes-1.9749/t/sleep.t Time-HiRes-1.9749/t/tv_interval.t Time-HiRes-1.9749/t/itimer.t Time-HiRes-1.9749/t/Watchdog.pm Time-HiRes-1.9749/t/alarm.t Time-HiRes-1.9749/t/stat.t Time-HiRes-1.9749/t/nanosleep.t Time-HiRes-1.9749/t/gettimeofday.t Time-HiRes-1.9749/t/usleep.t Time-HiRes-1.9749/t/clock.t Time-HiRes-1.9749/t/ualarm.t Time-HiRes-1.9749/fallback/const-c.inc Time-HiRes-1.9749/fallback/const-xs.inc Configuring J/JH/JHI/Time-HiRes-1.9749.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.9749.tar.gz /data/fly2200/ap2200-299134/bin/perl-static Makefile.PL -- OK Running make for J/JH/JHI/Time-HiRes-1.9749.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.9749\" -DXS_VERSION=\"1.9749\" -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.9749.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 24171, starting the watchdog process... # The watchdog process 24172 launched, continuing testing... # I am the watchdog process 24172, sleeping for 360 seconds... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.301414 # Select returned! 4 0.301478 # 0.899507333333333 # Tick! 3 0.60322 # Select returned! 3 0.603252 # 0.798916 # Tick! 2 0.903449 # Select returned! 2 0.903485 # 0.698838333333333 # Tick! 1 1.2037 # Select returned! 1 1.203733 # 0.598755666666667 # Tick! 0 1.504722 # Select returned! 0 1.504753 # 0.498415666666667 # ok 2 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1514016533.43082, t0 = 1514016533.43075, dt = 6.58035278320312e-05 # N = 2048, t1 = 1514016533.43097, t0 = 1514016533.43084, dt = 0.000126838684082031 # N = 4096, t1 = 1514016533.43123, t0 = 1514016533.43097, dt = 0.000254154205322266 # N = 8192, t1 = 1514016533.43175, t0 = 1514016533.43124, dt = 0.000517129898071289 # N = 16384, t1 = 1514016533.43279, t0 = 1514016533.43176, dt = 0.0010221004486084 # N = 32768, t1 = 1514016533.43578, t0 = 1514016533.43279, dt = 0.00298595428466797 # N = 65536, t1 = 1514016533.43989, t0 = 1514016533.4358, dt = 0.00408315658569336 # N = 131072, t1 = 1514016533.44823, t0 = 1514016533.4399, dt = 0.0083320140838623 # N = 262144, t1 = 1514016533.46489, t0 = 1514016533.44825, dt = 0.0166380405426025 # Alarm 1 - 1514016533.48478 # Alarm 2 - 1514016533.51996 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 24171, terminating the watchdog process 24172 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 24172 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 24173, starting the watchdog process... # The watchdog process 24174 launched, continuing testing... # I am the watchdog process 24174, 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 = 1514016539.24399, t0 = 1514016537.74272 # dt = 1.50127196311951, rt = 0.000847975413004631 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 24173, terminating the watchdog process 24174 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 24174 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 24175, starting the watchdog process... # The watchdog process 24176 launched, continuing testing... # gettimeofday returned 2 args # I am the watchdog process 24176, sleeping for 360 seconds... ok 1 ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 24175, terminating the watchdog process 24176 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 24176 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 24177, starting the watchdog process... # The watchdog process 24178 launched, continuing testing... # setitimer: 0 0 ok 1 - ITIMER_VIRTUAL defined with sufficient granularity # getitimer: 0.504031 0.400025 # I am the watchdog process 24178, sleeping for 360 seconds... # Tick! 2 0.763909 # Tick! 1 1.373749 # Tick! 0 1.966792 # Tick! 0 2.593765 # getitimer: 0 0 # at end, i=0 ok 2 - time left should be zero # I am the main process 24177, terminating the watchdog process 24178 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 24178 = 1 # All done. ok t/nanosleep.t ..... 1..4 # I am the main process 24179, starting the watchdog process... # The watchdog process 24180 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 24180, sleeping for 360 seconds... ok 2 ok 3 - nanosleep for more than 0.4 sec ok 4 # I am the main process 24179, terminating the watchdog process 24180 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 24180 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 24181, starting the watchdog process... # The watchdog process 24182 launched, continuing testing... # I am the watchdog process 24182, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1514016545.22639 ok 3 # sleep...0.50022 ok 4 # I am the main process 24181, terminating the watchdog process 24182 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 24182 = 1 # All done. ok t/stat.t .......... 1..43 # I am the main process 24183, starting the watchdog process... # The watchdog process 24184 launched, continuing testing... # I am the watchdog process 24184, 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 = 1514016545.93885 1514016546.21085 1514016546.57885 1514016546.92685 1514016547.29085 # atime = 1514016546.07486 1514016546.40685 1514016546.76285 1514016547.12285 1514016547.42686 # 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 24183, terminating the watchdog process 24184 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 24184 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 24185, starting the watchdog process... # The watchdog process 24186 launched, continuing testing... # I am the watchdog process 24186, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 # s = 47.7808730602264, n = 100, s/n = 0.477808730602264 # I am the main process 24185, terminating the watchdog process 24186 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 24186 = 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 24188, starting the watchdog process... # The watchdog process 24189 launched, continuing testing... # I am the watchdog process 24189, sleeping for 360 seconds... ok 1 # tick = 1, one = 1514016547, two = 1514016547, three = 1514016547 ok 2 # tick = 3, one = 1514016547, two = 1514016547, three = 1514016547 ok 3 - negative time error # t0 = 1514016547.62459 # ualarm(100000) # t1 = 1514016547.72535 # dt = 0.100762844085693 # r = 1.00762844085693 ok 4 # t0 = 1514016547.72535 # ualarm(1100000) # t1 = 1514016548.82546 # dt = 1.10010313987732 # r = 1.00009376352484 ok 5 # t0 = 1514016548.82588 # ualarm(2200000) # t1 = 1514016551.03485 # dt = 2.20896697044373 # r = 1.00407589565624 ok 6 # t0 = 1514016551.03525 # ualarm(4300000) # t1 = 1514016555.34186 # dt = 4.3066132068634 # r = 1.00153795508451 ok 7 # t0 = 1514016555.34186 # got0 = 0 # t1 = 1514016555.64186 # t1 - t0 = 0.300000905990601 # got1 = 200127 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 24188, terminating the watchdog process 24189 before it terminates me in 352 seconds (testing took 8 seconds). # kill KILL 24189 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 24191, starting the watchdog process... # The watchdog process 24192 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 24192, sleeping for 360 seconds... ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 24191, terminating the watchdog process 24192 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 24192 = 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.9749-fDg35N # Subsecond file timestamps in /data/fly2200/cpanfly-5.22/var/tmp/cpan_build/Time-HiRes-1.9749-fDg35N: OK 1..18 # I am the main process 24193, starting the watchdog process... # The watchdog process 24194 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 # I am the watchdog process 24194, sleeping for 360 seconds... 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 24193, terminating the watchdog process 24194 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 24194 = 1 # All done. ok All tests successful. Files=12, Tests=114, 29 wallclock secs ( 0.07 usr 0.04 sys + 15.20 cusr 0.24 csys = 15.55 CPU) Result: PASS JHI/Time-HiRes-1.9749.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.9749-fDg35N && tar cvf - Time-HiRes-1.9749.ppd blib) | gzip -c >/data/fly2200/cpanfly-5.22/var/REPO/J/JH/JHI/Time-HiRes-1.9749.tar.gz Time-HiRes-1.9749.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: 364784 kB Finished 2017-12-23T00:09:21