PATH=/usr/bin:/bin:/data/fly2200/cpanfly-5.22/var/megalib/bin Start 2016-04-24T06:27:34 ActivePerl-2200 CPAN-2.10 Reading '/data/fly2200/cpanfly-5.22/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/fly2200/cpanfly-5.22/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/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 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/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.9733.tar.gz /data/fly2200/ap2200-299134/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/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.9733\" -DXS_VERSION=\"1.9733\" -fPIC "-I/home/fly2200/ap2200-299134/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/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.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/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 15536, starting the watchdog process... # The watchdog process 15537 launched, continuing testing... # I am the watchdog process 15537, sleeping for 360 seconds... ok 1 - require Time::HiRes; # sigaction tick, ALRM = 14 # Tick! 4 0.300269 # Select returned! 4 0.300358 # 0.899880666666667 # Tick! 3 0.600539 # Select returned! 3 0.60062 # 0.799793333333333 # Tick! 2 0.900796 # Select returned! 2 0.900881 # 0.699706333333333 # Tick! 1 1.201114 # Select returned! 1 1.201194 # 0.599602 # Tick! 0 1.50137 # Select returned! 0 1.501491 # 0.499503 ok 2 # 0 ok 3 - negative time error # Finding delay loop... # N = 1024, t1 = 1461504463.39493, t0 = 1461504463.39487, dt = 6.60419464111328e-05 # N = 2048, t1 = 1461504463.39512, t0 = 1461504463.39497, dt = 0.000146150588989258 # N = 4096, t1 = 1461504463.39542, t0 = 1461504463.39517, dt = 0.000253915786743164 # N = 8192, t1 = 1461504463.39596, t0 = 1461504463.39545, dt = 0.000505924224853516 # N = 16384, t1 = 1461504463.397, t0 = 1461504463.39598, dt = 0.00101995468139648 # N = 32768, t1 = 1461504463.39976, t0 = 1461504463.39708, dt = 0.00267291069030762 # N = 65536, t1 = 1461504463.40396, t0 = 1461504463.39985, dt = 0.00411105155944824 # N = 131072, t1 = 1461504463.41263, t0 = 1461504463.40404, dt = 0.00859189033508301 # N = 262144, t1 = 1461504463.42928, t0 = 1461504463.4127, dt = 0.0165791511535645 # Alarm 1 - 1461504463.43952 # Alarm 2 - 1461504463.47285 ok 4 ok 5 ok 6 ok 7 ok 8 ok 9 ok 10 # I am the main process 15536, terminating the watchdog process 15537 before it terminates me in 354 seconds (testing took 6 seconds). # kill KILL 15537 = 1 # All done. ok t/clock.t ......... 1..5 # I am the main process 15538, starting the watchdog process... # The watchdog process 15539 launched, continuing testing... # I am the watchdog process 15539, 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 = 1461504469.2283, t0 = 1461504467.728 # dt = 1.50030183792114, rt = 0.000201225280761719 ok 2 ok 3 ok 4 # clock = 0.04 # clock = 0.04 0.1 # clock = 0.04 0.1 0.16 # clock = 0.04 0.1 0.16 0.23 ok 5 # I am the main process 15538, terminating the watchdog process 15539 before it terminates me in 357 seconds (testing took 3 seconds). # kill KILL 15539 = 1 # All done. ok t/gettimeofday.t .. 1..6 # I am the main process 15540, starting the watchdog process... # I am the watchdog process 15541, sleeping for 360 seconds... # The watchdog process 15541 launched, continuing testing... # gettimeofday returned 2 args ok 1 ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 15540, terminating the watchdog process 15541 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 15541 = 1 # All done. ok t/itimer.t ........ 1..2 # I am the main process 15542, starting the watchdog process... # The watchdog process 15543 launched, continuing testing... # setitimer: 0 0 # I am the watchdog process 15543, sleeping for 360 seconds... ok 1 - ITIMER_VIRTUAL defined with sufficient granularity # getitimer: 0.500031 0.400025 # Tick! 2 0.503229 # Tick! 1 0.902622 # Tick! 0 1.30281 # Tick! 0 1.702863 # getitimer: 0 0 # at end, i=0 ok 2 - time left should be zero # I am the main process 15542, terminating the watchdog process 15543 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 15543 = 1 # All done. ok t/nanosleep.t ..... 1..3 # I am the main process 15544, starting the watchdog process... # The watchdog process 15545 launched, continuing testing... ok 1 - negative time error # I am the watchdog process 15545, sleeping for 360 seconds... ok 2 ok 3 # I am the main process 15544, terminating the watchdog process 15545 before it terminates me in 359 seconds (testing took 1 seconds). # kill KILL 15545 = 1 # All done. ok t/sleep.t ......... 1..4 # I am the main process 15546, starting the watchdog process... # The watchdog process 15547 launched, continuing testing... # I am the watchdog process 15547, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 - negative time error # time...1461504474.32259 ok 3 # sleep...0.500984 ok 4 # I am the main process 15546, terminating the watchdog process 15547 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 15547 = 1 # All done. ok t/stat.t .......... 1..43 # I am the main process 15548, starting the watchdog process... # The watchdog process 15549 launched, continuing testing... # I am the watchdog process 15549, 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 = 1461504475.00117 1461504475.37716 1461504475.69717 1461504475.99716 1461504476.27716 # atime = 1461504475.17717 1461504475.56116 1461504475.86516 1461504476.15717 1461504476.47716 # 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 15548, terminating the watchdog process 15549 before it terminates me in 358 seconds (testing took 2 seconds). # kill KILL 15549 = 1 # All done. ok t/time.t .......... 1..2 # I am the main process 15550, starting the watchdog process... # The watchdog process 15551 launched, continuing testing... # I am the watchdog process 15551, sleeping for 360 seconds... ok 1 - require Time::HiRes; ok 2 # s = 52.8219640254974, n = 100, s/n = 0.528219640254974 # I am the main process 15550, terminating the watchdog process 15551 before it terminates me in 360 seconds (testing took 0 seconds). # kill KILL 15551 = 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 15553, starting the watchdog process... # The watchdog process 15554 launched, continuing testing... # I am the watchdog process 15554, sleeping for 360 seconds... ok 1 # tick = 1, one = 1461504476, two = 1461504476, three = 1461504476 ok 2 # tick = 3, one = 1461504476, two = 1461504476, three = 1461504476 ok 3 - negative time error # t0 = 1461504476.66641 # ualarm(100000) # t1 = 1461504476.76659 # dt = 0.100183010101318 # r = 1.00183010101318 ok 4 # t0 = 1461504476.76704 # ualarm(1100000) # t1 = 1461504477.8672 # dt = 1.10015988349915 # r = 1.00014534863559 ok 5 # t0 = 1461504477.86757 # ualarm(2200000) # t1 = 1461504480.06849 # dt = 2.20091700553894 # r = 1.00041682069952 ok 6 # t0 = 1461504480.06874 # ualarm(4300000) # t1 = 1461504484.36923 # dt = 4.30049586296082 # r = 1.00011531696763 ok 7 # t0 = 1461504484.36986 # got0 = 0 # t1 = 1461504484.66986 # t1 - t0 = 0.300000905990601 # got1 = 200001 ok 8 ok 9 ok 10 ok 11 ok 12 # I am the main process 15553, terminating the watchdog process 15554 before it terminates me in 352 seconds (testing took 8 seconds). # kill KILL 15554 = 1 # All done. ok t/usleep.t ........ 1..6 # I am the main process 15555, starting the watchdog process... # The watchdog process 15556 launched, continuing testing... # I am the watchdog process 15556, sleeping for 360 seconds... ok 1 - negative time error ok 2 ok 3 ok 4 ok 5 ok 6 # I am the main process 15555, terminating the watchdog process 15556 before it terminates me in 356 seconds (testing took 4 seconds). # kill KILL 15556 = 1 # All done. ok All tests successful. Files=11, Tests=95, 27 wallclock secs ( 0.09 usr 0.01 sys + 14.52 cusr 0.11 csys = 14.73 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/fly2200/cpanfly-5.22/var/cpan/build/Time-HiRes-1.9733-OuxbjD && tar cvf - Time-HiRes-1.9733.ppd blib) | gzip -c >/data/fly2200/cpanfly-5.22/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/fly2200/cpanfly-5.22/var/cpan/build/Time-HiRes-1.9733-OuxbjD/Time-HiRes-1.9733.ppd /data/fly2200/cpanfly-5.22/var/REPO/J/JH/JHI VmSize: 334844 kB Finished 2016-04-24T06:28:08