PATH=/usr/bin:/bin:/data/fly2000/cpanfly-5.20/var/megalib/bin Start 2016-04-24T16:38:19 ActivePerl-2000 CPAN-2.10 Reading '/data/fly2000/cpanfly-5.20/var/cpan/Metadata' Database was generated on Sun, 24 Apr 2016 04:17:02 GMT Fetching with LWP: http://ppm.activestate.com/CPAN/authors/id/J/JH/JHI/Time-HiRes-1.9733.tar.gz Fetching with LWP: http://ppm.activestate.com/CPAN/authors/id/J/JH/JHI/CHECKSUMS Checksum for /data/fly2000/cpanfly-5.20/var/cpan/sources/authors/id/J/JH/JHI/Time-HiRes-1.9733.tar.gz ok Time-HiRes-1.9733/ Time-HiRes-1.9733/Changes Time-HiRes-1.9733/fallback/ Time-HiRes-1.9733/hints/ Time-HiRes-1.9733/HiRes.pm Time-HiRes-1.9733/HiRes.xs Time-HiRes-1.9733/Makefile.PL Time-HiRes-1.9733/MANIFEST Time-HiRes-1.9733/META.json Time-HiRes-1.9733/META.yml Time-HiRes-1.9733/ppport.h Time-HiRes-1.9733/README Time-HiRes-1.9733/t/ Time-HiRes-1.9733/TODO Time-HiRes-1.9733/typemap Time-HiRes-1.9733/t/alarm.t Time-HiRes-1.9733/t/clock.t Time-HiRes-1.9733/t/gettimeofday.t Time-HiRes-1.9733/t/itimer.t Time-HiRes-1.9733/t/nanosleep.t Time-HiRes-1.9733/t/sleep.t Time-HiRes-1.9733/t/stat.t Time-HiRes-1.9733/t/time.t Time-HiRes-1.9733/t/tv_interval.t Time-HiRes-1.9733/t/ualarm.t Time-HiRes-1.9733/t/usleep.t Time-HiRes-1.9733/t/Watchdog.pm Time-HiRes-1.9733/hints/aix.pl Time-HiRes-1.9733/hints/dec_osf.pl Time-HiRes-1.9733/hints/dynixptx.pl Time-HiRes-1.9733/hints/irix.pl Time-HiRes-1.9733/hints/linux.pl Time-HiRes-1.9733/hints/sco.pl Time-HiRes-1.9733/hints/solaris.pl Time-HiRes-1.9733/hints/svr4.pl Time-HiRes-1.9733/fallback/const-c.inc Time-HiRes-1.9733/fallback/const-xs.inc Configuring J/JH/JHI/Time-HiRes-1.9733.tar.gz with Makefile.PL >>> /data/fly2000/ap2000-298540/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 clock_gettime()... found. Looking for clock_getres()... found. Looking for clock_nanosleep()... found. Looking for clock()... 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...Processing hints file hints/linux.pl 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/fly2000/cpanfly-5.20/var/megalib Want /home/fly2000/ap2000-298540/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.9733.tar.gz /data/fly2000/ap2000-298540/bin/perl-static Makefile.PL -- OK Running make for J/JH/JHI/Time-HiRes-1.9733.tar.gz >>> make cp HiRes.pm blib/lib/Time/HiRes.pm Running Mkbootstrap for Time::HiRes () chmod 644 "HiRes.bs" "/data/fly2000/ap2000-298540/bin/perl-static" "/data/fly2000/cpanfly-5.20/var/megalib/ExtUtils/xsubpp" -typemap "/home/fly2000/ap2000-298540/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.9733\" -DXS_VERSION=\"1.9733\" -fPIC "-I/home/fly2000/ap2000-298540/lib/CORE" -DTIME_HIRES_NANOSLEEP -DTIME_HIRES_CLOCK_GETTIME -DTIME_HIRES_CLOCK_GETRES -DTIME_HIRES_CLOCK_NANOSLEEP -DTIME_HIRES_CLOCK -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/fly2000/ap2000-298540/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.9733.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/fly2000/ap2000-298540/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 21670, starting the watchdog process... # The watchdog process 21671 launched, continuing testing... # I am the watchdog process 21671, sleeping for 360 seconds... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.300255 # Select returned! 4 0.300345 # 0.899885 # Tick! 3 0.600578 # Select returned! 3 0.600651 # 0.799783 # Tick! 2 0.900828 # Select returned! 2 0.900957 # 0.699681 # Tick! 1 1.201138 # Select returned! 1 1.201211 # 0.599596333333333 # Tick! 0 1.501383 # Select returned! 0 1.501455 # 0.499515 ok 2 # 0 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1461541109.33698, t0 = 1461541109.3369, dt = 7.41481781005859e-05 # N = 2048, t1 = 1461541109.33715, t0 = 1461541109.33701, dt = 0.000137090682983398 # N = 4096, t1 = 1461541109.33746, t0 = 1461541109.3372, dt = 0.000256061553955078 # N = 8192, t1 = 1461541109.33846, t0 = 1461541109.33749, dt = 0.000976085662841797 # N = 16384, t1 = 1461541109.33957, t0 = 1461541109.33852, dt = 0.00105714797973633 # N = 32768, t1 = 1461541109.34252, t0 = 1461541109.33962, dt = 0.00290298461914062 # N = 65536, t1 = 1461541109.34651, t0 = 1461541109.34258, dt = 0.00392413139343262 # N = 131072, t1 = 1461541109.355, t0 = 1461541109.34657, dt = 0.00843095779418945 # N = 262144, t1 = 1461541109.37186, t0 = 1461541109.35507, dt = 0.0167889595031738 # Alarm 1 - 1461541109.38206 # Alarm 2 - 1461541109.41612 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 21670, terminating the watchdog process 21671 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 21671 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 21672, starting the watchdog process... # The watchdog process 21673 launched, continuing testing... # I am the watchdog process 21673, 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 = 1461541115.17306, t0 = 1461541113.67274 # dt = 1.50032591819763, rt = 0.00021727879842115 ok 2 ok 3 ok 4 # clock = 0.04 # clock = 0.04 0.11 # clock = 0.04 0.11 0.18 # clock = 0.04 0.11 0.18 0.24 ok 5 # I am the main process 21672, terminating the watchdog process 21673 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 21673 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 21676, starting the watchdog process... # The watchdog process 21677 launched, continuing testing... # gettimeofday returned 2 args # I am the watchdog process 21677, sleeping for 360 seconds... ok 1 ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 21676, terminating the watchdog process 21677 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 21677 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 21678, starting the watchdog process... # The watchdog process 21679 launched, continuing testing... # setitimer: 0 0 # I am the watchdog process 21679, sleeping for 360 seconds... ok 1 - ITIMER_VIRTUAL defined with sufficient granularity # getitimer: 0.504031 0.400025 # Tick! 2 0.509163 # Tick! 1 0.909549 # Tick! 0 1.30944 # Tick! 0 1.713069 # getitimer: 0 0 # at end, i=0 ok 2 - time left should be zero # I am the main process 21678, terminating the watchdog process 21679 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 21679 = 1 # All done. ok t/nanosleep.t ..... 1..3 # I am the main process 21680, starting the watchdog process... # The watchdog process 21681 launched, continuing testing... # I am the watchdog process 21681, sleeping for 360 seconds... ok 1 - negative time error ok 2 ok 3 # I am the main process 21680, terminating the watchdog process 21681 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 21681 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 21682, starting the watchdog process... # The watchdog process 21683 launched, continuing testing... # I am the watchdog process 21683, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1461541120.31061 ok 3 # sleep...0.500157 ok 4 # I am the main process 21682, terminating the watchdog process 21683 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 21683 = 1 # All done. ok t/stat.t .......... 1..43 # I am the main process 21684, starting the watchdog process... # I am the watchdog process 21685, sleeping for 360 seconds... # The watchdog process 21685 launched, continuing testing... 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 = 1461541120.95303 1461541121.20103 1461541121.47703 1461541121.71303 1461541122.01303 # atime = 1461541121.07703 1461541121.30503 1461541121.60903 1461541121.84903 1461541122.15703 # 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 21684, terminating the watchdog process 21685 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 21685 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 21686, starting the watchdog process... # The watchdog process 21687 launched, continuing testing... # I am the watchdog process 21687, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 # s = 20.9161355495453, n = 100, s/n = 0.209161355495453 # I am the main process 21686, terminating the watchdog process 21687 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 21687 = 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 21689, starting the watchdog process... # The watchdog process 21690 launched, continuing testing... # I am the watchdog process 21690, sleeping for 360 seconds... ok 1 # tick = 1, one = 1461541122, two = 1461541122, three = 1461541122 ok 2 # tick = 3, one = 1461541122, two = 1461541122, three = 1461541122 ok 3 - negative time error # t0 = 1461541122.34916 # ualarm(100000) # t1 = 1461541122.45214 # dt = 0.102982997894287 # r = 1.02982997894287 ok 4 # t0 = 1461541122.45248 # ualarm(1100000) # t1 = 1461541123.55305 # dt = 1.10057783126831 # r = 1.00052530115301 ok 5 # t0 = 1461541123.55305 # ualarm(2200000) # t1 = 1461541125.75323 # dt = 2.20017504692078 # r = 1.00007956678217 ok 6 # t0 = 1461541125.75333 # ualarm(4300000) # t1 = 1461541130.05368 # dt = 4.3003408908844 # r = 1.00007927694986 ok 7 # t0 = 1461541130.05389 # got0 = 0 # t1 = 1461541130.35389 # t1 - t0 = 0.300000905990601 # got1 = 200012 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 21689, terminating the watchdog process 21690 before it terminates me in 352 seconds (testing took 8 seconds). # kill KILL 21690 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 21812, starting the watchdog process... # The watchdog process 21813 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 21813, sleeping for 360 seconds... ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 21812, terminating the watchdog process 21813 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 21813 = 1 # All done. ok All tests successful. Files=11, Tests=95, 27 wallclock secs ( 0.09 usr 0.02 sys + 14.41 cusr 0.08 csys = 14.60 CPU) Result: PASS JHI/Time-HiRes-1.9733.tar.gz make test TEST_VERBOSE=1 -- OK Jarkko Hietaniemi <jhi@iki.fi> High resolution alarm, sleep, gettimeofday, interval timers >>> (cd /data/fly2000/cpanfly-5.20/var/cpan/build/Time-HiRes-1.9733-jsnfGF && tar cvf - Time-HiRes-1.9733.ppd blib) | gzip -c >/data/fly2000/cpanfly-5.20/var/REPO/J/JH/JHI/Time-HiRes-1.9733.tar.gz Time-HiRes-1.9733.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 >>> mv /data/fly2000/cpanfly-5.20/var/cpan/build/Time-HiRes-1.9733-jsnfGF/Time-HiRes-1.9733.ppd /data/fly2000/cpanfly-5.20/var/REPO/J/JH/JHI VmSize: 329108 kB Finished 2016-04-24T16:38:54