PATH=/usr/bin:/bin:/data/fly2200/cpanfly-5.22/var/megalib/bin Start 2019-02-20T00:01:11 ActivePerl-2200 CPAN-2.10 Reading '/data/fly2200/cpanfly-5.22/var/cpan/Metadata' Database was generated on Tue, 19 Feb 2019 06:55:15 GMT Checksum for /data/fly2200/cpanfly-5.22/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/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'. ATOOMIC/Time-HiRes-1.9760.tar.gz /data/fly2200/ap2200-299134/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 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.9760\" -DXS_VERSION=\"1.9760\" -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 -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 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 ATOOMIC/Time-HiRes-1.9760.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 6149, starting the watchdog process... # The watchdog process 6150 launched, continuing testing... # I am the watchdog process 6150, sleeping for 360 seconds... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.30078 # Select returned! 4 0.300835 # 0.899721666666667 # Tick! 3 0.600961 # Select returned! 3 0.600993 # 0.799669 # Tick! 2 0.90124 # Select returned! 2 0.901322 # 0.699559333333333 # Tick! 1 1.201478 # Select returned! 1 1.201519 # 0.599493666666667 # Tick! 0 1.501632 # Select returned! 0 1.501665 # 0.499445 # ok 2 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1550649680.96943, t0 = 1550649680.96936, dt = 6.81877136230469e-05 # N = 2048, t1 = 1550649680.96957, t0 = 1550649680.96945, dt = 0.000128030776977539 # N = 4096, t1 = 1550649680.96984, t0 = 1550649680.96958, dt = 0.000255107879638672 # N = 8192, t1 = 1550649680.97037, t0 = 1550649680.96985, dt = 0.000519990921020508 # N = 16384, t1 = 1550649680.9714, t0 = 1550649680.97038, dt = 0.00101995468139648 # N = 32768, t1 = 1550649680.97343, t0 = 1550649680.97141, dt = 0.00201892852783203 # N = 65536, t1 = 1550649680.97752, t0 = 1550649680.97344, dt = 0.00408196449279785 # N = 131072, t1 = 1550649680.98728, t0 = 1550649680.97753, dt = 0.0097510814666748 # N = 262144, t1 = 1550649681.00387, t0 = 1550649680.98731, dt = 0.0165579319000244 # Alarm 1 - 1550649681.02076 # Alarm 2 - 1550649681.05269 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 6149, terminating the watchdog process 6150 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 6150 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 6151, starting the watchdog process... # The watchdog process 6152 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 6152, sleeping for 360 seconds... # t1 = 1550649686.77737, t0 = 1550649685.27707 # dt = 1.50029850006104, rt = 0.000199000040690178 ok 2 ok 3 ok 4 # CLOCKS_PER_SEC = 1000000 # delay = 1000000 # clock = 0.03 # clock = 0.03 0.09 # clock = 0.03 0.09 0.15 # clock = 0.03 0.09 0.15 0.22 ok 5 # I am the main process 6151, terminating the watchdog process 6152 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 6152 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 6153, starting the watchdog process... # The watchdog process 6154 launched, continuing testing... # gettimeofday returned 2 args ok 1 # I am the watchdog process 6154, sleeping for 360 seconds... ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 6153, terminating the watchdog process 6154 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 6154 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 6155, starting the watchdog process... # The watchdog process 6156 launched, continuing testing... # setitimer: 0 0 ok 1 - ITIMER_VIRTUAL defined with sufficient granularity # getitimer: 0.504031 0.400025 # I am the watchdog process 6156, sleeping for 360 seconds... # Tick! 2 0.798105 # Tick! 1 1.398094 # Tick! 0 2.01821 # Tick! 0 2.608332 # getitimer: 0 0 # at end, i=0 ok 2 - time left should be zero # I am the main process 6155, terminating the watchdog process 6156 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 6156 = 1 # All done. ok t/nanosleep.t ..... 1..4 # I am the main process 6157, starting the watchdog process... # The watchdog process 6158 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 6158, sleeping for 360 seconds... ok 2 ok 3 - nanosleep for more than 0.4 sec ok 4 # I am the main process 6157, terminating the watchdog process 6158 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 6158 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 6159, starting the watchdog process... # The watchdog process 6160 launched, continuing testing... ok 1 - require Time::HiRes; # I am the watchdog process 6160, sleeping for 360 seconds... ok 2 - negative time error # time...1550649692.77231 ok 3 # sleep...0.500142 ok 4 # I am the main process 6159, terminating the watchdog process 6160 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 6160 = 1 # All done. ok t/stat.t .......... 1..43 # I am the main process 6161, starting the watchdog process... # The watchdog process 6162 launched, continuing testing... # I am the watchdog process 6162, 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 = 1550649693.49709 1550649693.7771 1550649694.13309 1550649694.42509 1550649694.69309 # atime = 1550649693.6371 1550649693.9731 1550649694.2811 1550649694.54909 1550649694.84109 # 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 6161, terminating the watchdog process 6162 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 6162 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 6163, starting the watchdog process... # The watchdog process 6164 launched, continuing testing... # I am the watchdog process 6164, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 # s = 88.966819524765, n = 100, s/n = 0.88966819524765 # I am the main process 6163, terminating the watchdog process 6164 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 6164 = 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 6166, starting the watchdog process... # The watchdog process 6167 launched, continuing testing... # I am the watchdog process 6167, sleeping for 360 seconds... ok 1 # tick = 1, one = 1550649694, two = 1550649694, three = 1550649694 ok 2 # tick = 3, one = 1550649694, two = 1550649694, three = 1550649694 ok 3 - negative time error # t0 = 1550649695.04132 # ualarm(100000) # t1 = 1550649695.15081 # dt = 0.109491109848022 # r = 1.09491109848022 ok 4 # t0 = 1550649695.15103 # ualarm(1100000) # t1 = 1550649696.26085 # dt = 1.10982012748718 # r = 1.00892738862471 ok 5 # t0 = 1550649696.26116 # ualarm(2200000) # t1 = 1550649698.47085 # dt = 2.20969009399414 # r = 1.00440458817915 ok 6 # t0 = 1550649698.47125 # ualarm(4300000) # t1 = 1550649702.78085 # dt = 4.30960297584534 # r = 1.00223325019659 ok 7 # t0 = 1550649702.78125 # got0 = 0 # t1 = 1550649703.08125 # t1 - t0 = 0.300000905990601 # got1 = 200011 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 6166, terminating the watchdog process 6167 before it terminates me in 351 seconds (testing took 9 seconds). # kill KILL 6167 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 6168, starting the watchdog process... # I am the watchdog process 6169, sleeping for 360 seconds... # The watchdog process 6169 launched, continuing testing... ok 1 - negative time error ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 6168, terminating the watchdog process 6169 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 6169 = 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.9760-fvBIfy # Subsecond file timestamps in /data/fly2200/cpanfly-5.22/var/tmp/cpan_build/Time-HiRes-1.9760-fvBIfy: OK 1..22 # I am the main process 6170, starting the watchdog process... # The watchdog process 6171 launched, continuing testing... # $^O = linux, atime = 1.111111111, mtime = 2.222222222 # I am the watchdog process 6171, sleeping for 360 seconds... # 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 6170, terminating the watchdog process 6171 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 6171 = 1 # All done. ok All tests successful. Files=12, Tests=118, 29 wallclock secs ( 0.07 usr 0.03 sys + 15.24 cusr 0.26 csys = 15.60 CPU) Result: PASS ATOOMIC/Time-HiRes-1.9760.tar.gz make test TEST_VERBOSE=1 -- OK Fetching with LWP: http://ppm.activestate.com/CPAN/authors/id/A/AT/ATOOMIC/CHECKSUMS Nicolas R. <atoomic@cpan.org> High resolution alarm, sleep, gettimeofday, interval timers >>> (cd /data/fly2200/cpanfly-5.22/var/tmp/cpan_build/Time-HiRes-1.9760-fvBIfy && tar cvf - Time-HiRes-1.9760.ppd blib) | gzip -c >/data/fly2200/cpanfly-5.22/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: 384784 kB Finished 2019-02-20T00:01:48