PATH=/usr/bin:/bin:/data/fly2400/cpanfly-5.24/var/megalib/bin Start 2019-02-20T02:01:30 ActivePerl-2400 CPAN-2.10 Reading '/data/fly2400/cpanfly-5.24/var/cpan/Metadata' Database was generated on Tue, 19 Feb 2019 06:55:15 GMT Checksum for /data/fly2400/cpanfly-5.24/var/cpan/sources/authors/id/A/AT/ATOOMIC/Time-HiRes-1.9760.tar.gz ok Time-HiRes-1.9760/ Time-HiRes-1.9760/HiRes.xs Time-HiRes-1.9760/fallback/ Time-HiRes-1.9760/Changes Time-HiRes-1.9760/HiRes.pm Time-HiRes-1.9760/MANIFEST Time-HiRes-1.9760/ppport.h Time-HiRes-1.9760/t/ Time-HiRes-1.9760/README Time-HiRes-1.9760/TODO Time-HiRes-1.9760/typemap Time-HiRes-1.9760/META.yml Time-HiRes-1.9760/Makefile.PL Time-HiRes-1.9760/hints/ Time-HiRes-1.9760/META.json Time-HiRes-1.9760/hints/dynixptx.pl Time-HiRes-1.9760/hints/sco.pl Time-HiRes-1.9760/hints/svr4.pl Time-HiRes-1.9760/hints/dec_osf.pl Time-HiRes-1.9760/hints/solaris.pl Time-HiRes-1.9760/hints/aix.pl Time-HiRes-1.9760/hints/linux.pl Time-HiRes-1.9760/hints/irix.pl Time-HiRes-1.9760/t/utime.t Time-HiRes-1.9760/t/time.t Time-HiRes-1.9760/t/sleep.t Time-HiRes-1.9760/t/tv_interval.t Time-HiRes-1.9760/t/itimer.t Time-HiRes-1.9760/t/Watchdog.pm Time-HiRes-1.9760/t/alarm.t Time-HiRes-1.9760/t/stat.t Time-HiRes-1.9760/t/nanosleep.t Time-HiRes-1.9760/t/gettimeofday.t Time-HiRes-1.9760/t/usleep.t Time-HiRes-1.9760/t/clock.t Time-HiRes-1.9760/t/ualarm.t Time-HiRes-1.9760/fallback/const-c.inc Time-HiRes-1.9760/fallback/const-xs.inc Configuring A/AT/ATOOMIC/Time-HiRes-1.9760.tar.gz with Makefile.PL >>> /data/fly2400/ap2400-300558/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...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/fly2400/cpanfly-5.24/var/megalib Want /home/fly2400/ap2400-300558/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'. ATOOMIC/Time-HiRes-1.9760.tar.gz /data/fly2400/ap2400-300558/bin/perl-static Makefile.PL -- OK Running make for A/AT/ATOOMIC/Time-HiRes-1.9760.tar.gz >>> make cp HiRes.pm blib/lib/Time/HiRes.pm Running Mkbootstrap for HiRes () chmod 644 "HiRes.bs" "/data/fly2400/ap2400-300558/bin/perl-static" -MExtUtils::Command::MM -e 'cp_nonempty' -- HiRes.bs blib/arch/auto/Time/HiRes/HiRes.bs 644 "/data/fly2400/ap2400-300558/bin/perl-static" "/data/fly2400/cpanfly-5.24/var/megalib/ExtUtils/xsubpp" -typemap '/home/fly2400/ap2400-300558/lib/ExtUtils/typemap' -typemap '/data/fly2400/cpanfly-5.24/var/tmp/cpan_build/Time-HiRes-1.9760-3LqfpN/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.9760\" -DXS_VERSION=\"1.9760\" -fPIC "-I/home/fly2400/ap2400-300558/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 -DUSE_PPPORT_H HiRes.c rm -f blib/arch/auto/Time/HiRes/HiRes.so LD_RUN_PATH="/lib/x86_64-linux-gnu" gcc -shared -O2 -fstack-protector -o blib/arch/auto/Time/HiRes/HiRes.so HiRes.o \ -lrt \ chmod 755 blib/arch/auto/Time/HiRes/HiRes.so Manifying 1 pod document ATOOMIC/Time-HiRes-1.9760.tar.gz make -- OK Running make test >>> make test TEST_VERBOSE=1 "/data/fly2400/ap2400-300558/bin/perl-static" -MExtUtils::Command::MM -e 'cp_nonempty' -- HiRes.bs blib/arch/auto/Time/HiRes/HiRes.bs 644 PERL_DL_NONLAZY=1 "/data/fly2400/ap2400-300558/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 29085, starting the watchdog process... # The watchdog process 29086 launched, continuing testing... ok 1 - require Time::HiRes; # I am the watchdog process 29086, sleeping for 360 seconds... # sigaction tick, ALRM = 14 # Tick! 4 0.300386 # Select returned! 4 0.300386 # 0.899871333333333 # Tick! 3 0.600519 # Select returned! 3 0.600575 # 0.799808333333333 # Tick! 2 0.900674 # Select returned! 2 0.90071 # 0.699763333333333 # Tick! 1 1.200821 # Select returned! 1 1.200854 # 0.599715333333333 # Tick! 0 1.500935 # Select returned! 0 1.500967 # 0.499677666666667 # ok 2 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1550656901.05159, t0 = 1550656901.0515, dt = 8.60691070556641e-05 # N = 2048, t1 = 1550656901.05178, t0 = 1550656901.05161, dt = 0.000172138214111328 # N = 4096, t1 = 1550656901.0521, t0 = 1550656901.05179, dt = 0.000313997268676758 # N = 8192, t1 = 1550656901.05277, t0 = 1550656901.05211, dt = 0.000657081604003906 # N = 16384, t1 = 1550656901.05405, t0 = 1550656901.05277, dt = 0.00127410888671875 # N = 32768, t1 = 1550656901.05786, t0 = 1550656901.05406, dt = 0.00380182266235352 # N = 65536, t1 = 1550656901.06218, t0 = 1550656901.05789, dt = 0.00428485870361328 # N = 131072, t1 = 1550656901.07371, t0 = 1550656901.06264, dt = 0.0110688209533691 # Alarm 1 - 1550656901.08922 # Alarm 2 - 1550656901.10993 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 29085, terminating the watchdog process 29086 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 29086 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 29087, starting the watchdog process... # The watchdog process 29088 launched, continuing testing... ok 1 - require Time::HiRes; # have_clock_gettime = 1 # have_clock_getres = 1 # have_clock_nanosleep = 1 # have_clock = 1 # CLOCK_REALTIME: try = 1 # I am the watchdog process 29088, sleeping for 360 seconds... # t1 = 1550656906.90352, t0 = 1550656905.40325 # dt = 1.50026607513428, rt = 0.000177383422851562 ok 2 ok 3 ok 4 # CLOCKS_PER_SEC = 1000000 # delay = 1000000 # clock = 0.17 # clock = 0.17 0.24 # clock = 0.17 0.24 0.32 # clock = 0.17 0.24 0.32 0.4 ok 5 # I am the main process 29087, terminating the watchdog process 29088 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 29088 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 29089, starting the watchdog process... # The watchdog process 29090 launched, continuing testing... # gettimeofday returned 2 args ok 1 ok 2 # I am the watchdog process 29090, sleeping for 360 seconds... ok 3 ok 4 ok 5 ok 6 # I am the main process 29089, terminating the watchdog process 29090 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 29090 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 29091, starting the watchdog process... # The watchdog process 29092 launched, continuing testing... # setitimer: 0 0 # I am the watchdog process 29092, sleeping for 360 seconds... ok 1 - ITIMER_VIRTUAL defined with sufficient granularity # getitimer: 0.504031 0.400025 # Tick! 2 0.802233 # Tick! 1 1.421957 # Tick! 0 2.032023 # Tick! 0 2.632025 # getitimer: 0 0 # at end, i=0 ok 2 - time left should be zero # I am the main process 29091, terminating the watchdog process 29092 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 29092 = 1 # All done. ok t/nanosleep.t ..... 1..4 # I am the main process 29093, starting the watchdog process... # The watchdog process 29094 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 29094, sleeping for 360 seconds... ok 2 ok 3 - nanosleep for more than 0.4 sec ok 4 # I am the main process 29093, terminating the watchdog process 29094 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 29094 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 29095, starting the watchdog process... # The watchdog process 29096 launched, continuing testing... # I am the watchdog process 29096, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1550656913.53797 ok 3 # sleep...0.500156 ok 4 # I am the main process 29095, terminating the watchdog process 29096 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 29096 = 1 # All done. ok t/stat.t .......... 1..43 # I am the main process 29097, starting the watchdog process... # The watchdog process 29098 launched, continuing testing... # I am the watchdog process 29098, 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 = 1550656914.32401 1550656914.60401 1550656914.96801 1550656915.228 1550656915.59201 # atime = 1550656914.46001 1550656914.784 1550656915.09601 1550656915.42001 1550656915.79201 # 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 29097, terminating the watchdog process 29098 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 29098 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 29099, starting the watchdog process... # The watchdog process 29100 launched, continuing testing... ok 1 - require Time::HiRes; # I am the watchdog process 29100, sleeping for 360 seconds... ok 2 # s = 98.0704600811005, n = 100, s/n = 0.980704600811005 # I am the main process 29099, terminating the watchdog process 29100 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 29100 = 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 29102, starting the watchdog process... # The watchdog process 29103 launched, continuing testing... # I am the watchdog process 29103, sleeping for 360 seconds... ok 1 # tick = 1, one = 1550656916, two = 1550656916, three = 1550656916 ok 2 # tick = 3, one = 1550656916, two = 1550656916, three = 1550656916 ok 3 - negative time error # t0 = 1550656916.40994 # ualarm(100000) # t1 = 1550656916.51144 # dt = 0.101499795913696 # r = 1.01499795913696 ok 4 # t0 = 1550656916.51319 # ualarm(1100000) # t1 = 1550656917.61844 # dt = 1.10525488853455 # r = 1.00477717139504 ok 5 # t0 = 1550656917.61898 # ualarm(2200000) # t1 = 1550656919.81926 # dt = 2.20027422904968 # r = 1.00012464956804 ok 6 # t0 = 1550656919.81967 # ualarm(4300000) # t1 = 1550656924.12928 # dt = 4.30961608886719 # r = 1.00223629973656 ok 7 # t0 = 1550656924.12971 # got0 = 0 # t1 = 1550656924.42972 # t1 - t0 = 0.30000114440918 # got1 = 200002 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 29102, terminating the watchdog process 29103 before it terminates me in 352 seconds (testing took 8 seconds). # kill KILL 29103 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 29104, starting the watchdog process... # The watchdog process 29105 launched, continuing testing... # I am the watchdog process 29105, sleeping for 360 seconds... ok 1 - negative time error ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 29104, terminating the watchdog process 29105 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 29105 = 1 # All done. ok t/utime.t ......... # Testing for subsecond file timestamps (mtime) in /data/fly2400/cpanfly-5.24/var/tmp/cpan_build/Time-HiRes-1.9760-3LqfpN # Subsecond file timestamps in /data/fly2400/cpanfly-5.24/var/tmp/cpan_build/Time-HiRes-1.9760-3LqfpN: OK 1..22 # I am the main process 29106, starting the watchdog process... # The watchdog process 29107 launched, continuing testing... # I am the watchdog process 29107, sleeping for 360 seconds... # $^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 round-trip ok 7 - One file changed ok 8 - One file changed ok 9 - atime round trip ok ok 10 - mtime round trip ok utime $filename and $fh ok 11 - Two files changed ok 12 - File 1 atime set correctly ok 13 - File 1 mtime set correctly ok 14 - File 2 atime set correctly ok 15 - File 2 mtime set correctly # utime undef sets time to now ok 16 - Two files changed ok 17 - File 1 atime set correctly ok 18 - File 1 mtime set correctly ok 19 - File 2 atime set correctly ok 20 - File 2 mtime set correctly # negative atime dies ok 21 - negative time error # negative mtime dies; ok 22 - negative time error # I am the main process 29106, terminating the watchdog process 29107 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 29107 = 1 # All done. ok All tests successful. Files=12, Tests=118, 30 wallclock secs ( 0.08 usr 0.02 sys + 16.62 cusr 0.50 csys = 17.22 CPU) Result: PASS ATOOMIC/Time-HiRes-1.9760.tar.gz make test TEST_VERBOSE=1 -- OK Nicolas R. <atoomic@cpan.org> High resolution alarm, sleep, gettimeofday, interval timers >>> (cd /data/fly2400/cpanfly-5.24/var/tmp/cpan_build/Time-HiRes-1.9760-3LqfpN && tar cvf - Time-HiRes-1.9760.ppd blib) | gzip -c >/data/fly2400/cpanfly-5.24/var/REPO/A/AT/ATOOMIC/Time-HiRes-1.9760.tar.gz Time-HiRes-1.9760.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: 376200 kB Finished 2019-02-20T02:02:10