Re: [DynInst_API:] FATAL 68 Dyninst


Date: Wed, 25 Apr 2018 09:02:21 +0200
From: Alberto Olmo <aolmo.uab@xxxxxxxxx>
Subject: Re: [DynInst_API:] FATAL 68 Dyninst
Hello Xiaozhu,

I have doble checked and I don't get much more debug information than the one I sent you in the last email. All I can see is this:

Enabling DyninstAPI startup debug
Enabling DyninstAPI startup debug
Failed to set environment var to preload RT library
--FATAL-- #68: Dyninst was unable to create the specified process
--FATAL-- #68: create process failed bootstrap
DynInst Exception: Process creation failed, Object name: my_app
Creating process my_app in directory ./
[140571584620416]dynProcess.C[85]: stdin: 0, stdout: 1, stderr: 2
Failed to set environment var to preload RT library
--FATAL-- #68: Dyninst was unable to create the specified process
--FATAL-- #68: create process failed bootstrap
DynInst Exception: Process creation failed, Object name: my_app

I have also attached to this email the same log (log.txt) in the event you wanted to see it in a file as well as the logs from a successful Dyninst execution with a synthetic app, that only counts the number of times a function is called (mutator-counter-log.txt).

What do you think it may be happening?Â

Thank you very much for your help,


Alberto Olmo.


2018-04-24 17:19 GMT+02:00 Alberto Olmo <aolmo.uab@xxxxxxxxx>:
HiÂXiaozhu,

I currently don't have access to the machine where I have Dyninst installed. I will send the debugging log tomorrow if you don't mind,
I am using a 64 bit CentOS 7,

Thanks for your rapid response,



Alberto Olmo.


2018-04-24 16:49 GMT+02:00 Xiaozhu Meng <xmeng@xxxxxxxxxxx>:
Hi Alberto,

What's your platform (windows or linux; 32bit or 64bit)? Could you send me the debugging log from DYNINST_DEBUG_STARTUP=1ï

Thanks,

--Xiaozhu

On Tue, Apr 24, 2018 at 4:49 AM, Alberto Olmo <aolmo.uab@xxxxxxxxx> wrote:
To whom it may concern,

My name is Alberto, a student at the Universitat Autonoma de Barcelona, and I am currently trying to install the Dyninst API in order to use it in another application. I have been able to install version 9.3.2 and its dependencies and test it with a small program which counts the number of times a function is called. It works correctly.

However, now I am trying to use it in another application which (I think) needs to call BPatch::processCreate and I get the following errors:

Failed to set environment var to preload RT library
--FATAL-- #68: Dyninst was unable to create the specified process
--FATAL-- #68: create process failed bootstrap
DynInst Exception: Process creation failed, Object name: my_app
Â

I do have exported variables DYNINSTAPI_RT_LIB and DYNINST_API_RT_LIB to point toÂlibdyninstAPI_RT.soÂ(I think depending on the Dyninst version one or the other is needed) as well as set the flag DYNINST_DEBUG_STARTUP=1 to get more information about the problem.Â

I have also tried with older versions but the error I get is exactly the same,

What would you recommend me that I try?

I would really appreciate any help you could provide me,
Thank you very much in advance and sorry for the inconveniences,

Alberto Olmo.


_______________________________________________
Dyninst-api mailing list
Dyninst-api@xxxxxxxxxxx
https://lists.cs.wisc.edu/mailman/listinfo/dyninst-api



Enabling DyninstAPI startup debug
Creating process MiniApp in directory ./
Arguments: (1)
   0: MiniApp
Environment: (0)
[140541036951424]dynProcess.C[85]: stdin: 0, stdout: 1, stderr: 2
[140541036951424]unix.C[353]: Candidate RTLib is /home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so
[140541036951424]unix.C[353]: Candidate RTLib is /usr/local/lib//libdyninstAPI_RT.so
[140541036951424]unix.C[353]: Candidate RTLib is /home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so
[140541036951424]unix.C[353]: Candidate RTLib is /usr/local/lib//libdyninstAPI_RT.so
[140541036951424]unix.C[353]: Candidate RTLib is /home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so
[140541036951424]unix.C[353]: Candidate RTLib is /usr/local/lib//libdyninstAPI_RT.so
[140541036951424]unix.C[353]: Candidate RTLib is /home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so
[140541036951424]unix.C[353]: Candidate RTLib is /usr/local/lib//libdyninstAPI_RT.so
[140541036951424]unix.C[353]: Candidate RTLib is /usr/local/lib/libdyninstAPI_RT.so
Created process 4201
[140541036951424]dynProcess.C[343]: attempting to bootstrap process 4201
[140541036951424]Processing initial shared objects
[140541036951424]----
[140541036951424]mapped_object.C[151]:  about to parseImage
[140541036951424]mapped_object.C[153]: name /home/aolmo/Desktop/dyninst-tests/Counter-Mutator/MiniApp, codeBase 0x0, dataBase 0x0
[140541036951424]image.C[1220]:  about to create image
[140541036951424]image.C[1415]:  opening file /home/aolmo/Desktop/dyninst-tests/Counter-Mutator/MiniApp
[140541036951424]image.C[1506]:  before findMain
[140541036951424]image.C[1513]: findMain analysis succeeded.
[140541036951424]image.C[1544]:  before determineImageType
[140541036951424]image.C[1222]:  created image
[140541036951424]image.C[1227]: processing executable object
[140541036951424]mapped_object.C[200]:  creating mapped object
[140541036951424][mapped_object.C:105] Creating new mapped_object /home/aolmo/Desktop/dyninst-tests/Counter-Mutator/MiniApp/
[140541036951424][mapped_object.C:107] 	codeBase 0x0, codeOffset 0x400000, size 2568
[140541036951424][mapped_object.C:109] 	dataBase 0x0, dataOffset 0x600dd8, size 628
[140541036951424][mapped_object.C:111] 	fileDescriptor: code at 0x0, data 0x0
[140541036951424][mapped_object.C:113] 	Code: 0x400000 to 0x400a08
[140541036951424][mapped_object.C:115] 	Data: 0x600dd8 to 0x60104c
[140541036951424]mapped_object.C[205]:  leaving createMappedObject(/home/aolmo/Desktop/dyninst-tests/Counter-Mutator/MiniApp)
[140541036951424]dynProcess.C[719]: findSignalhandler(0x22dc0c0)
[140541036951424]dynProcess.C[725]: findSignalhandler(0x22dc0c0): gettingSymbolInfo
[140541036951424]dynProcess.C[736]: leaving findSignalhandler(0x22dc0c0)
[140541036951424]dynProcess.C[665]: adding shared object MiniApp, addr range 0x0 to 0xa08
[140541036951424]Begin getDyninstRTLibName
[140541036951424]unix.C[322]: Candidate RTLib is /home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so
[140541036951424]unix.C[322]: Candidate RTLib is /usr/local/lib//libdyninstAPI_RT.so
[140541036951424]unix.C[322]: Candidate RTLib is /home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so
[140541036951424]unix.C[322]: Candidate RTLib is /usr/local/lib//libdyninstAPI_RT.so
[140541036951424]unix.C[322]: Candidate RTLib is /home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so
[140541036951424]unix.C[322]: Candidate RTLib is /usr/local/lib//libdyninstAPI_RT.so
[140541036951424]unix.C[322]: Candidate RTLib is /home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so
[140541036951424]unix.C[322]: Candidate RTLib is /usr/local/lib//libdyninstAPI_RT.so
[140541036951424]unix.C[322]: Candidate RTLib is /usr/local/lib/libdyninstAPI_RT.so
[140541036951424]dynProcess.C[596]:  leave setAOut/setting main
Library: /usr/lib64/ld-2.17.so / 7f45a968f000, <lib>
[140541036951424]mapped_object.C[151]:  about to parseImage
[140541036951424]mapped_object.C[153]: name /usr/lib64/ld-2.17.so, codeBase 0x7f45a968f000, dataBase 0x7f45a968f000
[140541036951424]image.C[1220]:  about to create image
[140541036951424]image.C[1415]:  opening file /usr/lib64/ld-2.17.so
[140541036951424]image.C[1506]:  before findMain
[140541036951424]image.C[1513]: findMain analysis succeeded.
[140541036951424]image.C[1544]:  before determineImageType
[140541036951424]image.C[1222]:  created image
[140541036951424]image.C[1225]: processing shared object
[140541036951424]mapped_object.C[200]:  creating mapped object
[140541036951424][mapped_object.C:105] Creating new mapped_object /usr/lib64/ld-2.17.so/
[140541036951424][mapped_object.C:107] 	codeBase 0x7f45a968f000, codeOffset 0x0, size 134224
[140541036951424][mapped_object.C:109] 	dataBase 0x7f45a968f000, dataOffset 0x221b40, size 5176
[140541036951424][mapped_object.C:111] 	fileDescriptor: code at 0x7f45a968f000, data 0x7f45a968f000
[140541036951424][mapped_object.C:113] 	Code: 0x7f45a968f000 to 0x7f45a96afc50
[140541036951424][mapped_object.C:115] 	Data: 0x7f45a98b0b40 to 0x7f45a98b1f78
[140541036951424]mapped_object.C[205]:  leaving createMappedObject(/usr/lib64/ld-2.17.so)
[140541036951424]dynProcess.C[719]: findSignalhandler(0x230b660)
[140541036951424]dynProcess.C[725]: findSignalhandler(0x230b660): gettingSymbolInfo
[140541036951424]dynProcess.C[732]: findSignalhandler(0x230b660): addingSignalHandler(0x7f45a96a7ea0, 1)
[140541036951424]dynProcess.C[736]: leaving findSignalhandler(0x230b660)
[140541036951424]dynProcess.C[665]: adding shared object ld-2.17.so, addr range 0x7f45a968f000 to 0x7f45a96afc50
[140541036951424]----
[140541036951424]Stackwalker stepper 0x230bed0 is a DyninstDynamicStepper
[140541036951424]Stackwalker stepper 0x230bfb0 is a DebugStepper
[140541036951424]Stackwalker stepper 0x230c200 is a FrameFuncStepper
[140541036951424]Stackwalker stepper 0x230c280 is an AnalysisStepper
[140541036951424]Stackwalker stepper 0x230c430 is a SigHandlerStepper
[140541036951424]Stackwalker stepper 0x230c5f0 is a BottomOfStackStepper
[140541036951424]Stackwalker stepper 0x230c870 is a WandererStepper
[140541036951424][unix.C:510] - hasPassedMain returning 0 (7f45a9690170 7f45a9690170)
[140541036951424]dynProcess.C[373]: inserting breakpoint at main
[140541036951424]dynProcess.C[947]: added trap to entry of main, address 0x4006c8
[140541036951424]dynProcess.C[379]: continuing process to breakpoint
[140541036951424]dynProcess.C[387]: waiting for main() loop
[140541036951424]dynProcess.C[416]: bootstrap waiting for process to initialize
[140541036951424]mapped_object.C[151]:  about to parseImage
[140541036951424]mapped_object.C[153]: name /usr/lib64/ld-2.17.so, codeBase 0x7f45a968f000, dataBase 0x7f45a968f000
[140541036951424]image.C[1201]: returning pre-parsed image
[140541036951424]mapped_object.C[200]:  creating mapped object
[140541036951424][mapped_object.C:105] Creating new mapped_object /usr/lib64/ld-2.17.so/
[140541036951424][mapped_object.C:107] 	codeBase 0x7f45a968f000, codeOffset 0x0, size 134224
[140541036951424][mapped_object.C:109] 	dataBase 0x7f45a968f000, dataOffset 0x221b40, size 5176
[140541036951424][mapped_object.C:111] 	fileDescriptor: code at 0x7f45a968f000, data 0x7f45a968f000
[140541036951424][mapped_object.C:113] 	Code: 0x7f45a968f000 to 0x7f45a96afc50
[140541036951424][mapped_object.C:115] 	Data: 0x7f45a98b0b40 to 0x7f45a98b1f78
[140541036951424]mapped_object.C[205]:  leaving createMappedObject(/usr/lib64/ld-2.17.so)
[140541036951424]dynProcess.C[719]: findSignalhandler(0x2310220)
[140541036951424]dynProcess.C[725]: findSignalhandler(0x2310220): gettingSymbolInfo
[140541036951424]dynProcess.C[732]: findSignalhandler(0x2310220): addingSignalHandler(0x7f45a96a7ea0, 1)
[140541036951424]dynProcess.C[736]: leaving findSignalhandler(0x2310220)
[140541036951424]dynProcess.C[665]: adding shared object ld-2.17.so, addr range 0x7f45a968f000 to 0x7f45a96afc50
[140541036951424]dynProcess.C[387]: waiting for main() loop
[140541036951424]dynProcess.C[389]: We think the process is stopped, continuing
[140541036951424]dynProcess.C[416]: bootstrap waiting for process to initialize
[140541036951424]mapped_object.C[151]:  about to parseImage
[140541036951424]mapped_object.C[153]: name /home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so.9.3.2, codeBase 0x7f45a83ff000, dataBase 0x7f45a83ff000
[140541036951424]image.C[1220]:  about to create image
[140541036951424]image.C[1415]:  opening file /home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so.9.3.2
[140541036951424]image.C[1506]:  before findMain
[140541036951424]image.C[1513]: findMain analysis succeeded.
[140541036951424]image.C[1544]:  before determineImageType
[140541036951424]image.C[1222]:  created image
[140541036951424]image.C[1225]: processing shared object
[140541036951424]mapped_object.C[200]:  creating mapped object
[140541036951424][mapped_object.C:105] Creating new mapped_object /home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so.9.3.2/
[140541036951424][mapped_object.C:107] 	codeBase 0x7f45a83ff000, codeOffset 0x0, size 22844
[140541036951424][mapped_object.C:109] 	dataBase 0x7f45a83ff000, dataOffset 0x205d16, size 1222
[140541036951424][mapped_object.C:111] 	fileDescriptor: code at 0x7f45a83ff000, data 0x7f45a83ff000
[140541036951424][mapped_object.C:113] 	Code: 0x7f45a83ff000 to 0x7f45a840493c
[140541036951424][mapped_object.C:115] 	Data: 0x7f45a8604d16 to 0x7f45a86051dc
[140541036951424]mapped_object.C[205]:  leaving createMappedObject(/home/aolmo/soft/dyninst-9.3.2/install/lib/libdyninstAPI_RT.so.9.3.2)
[140541036951424]dynProcess.C[719]: findSignalhandler(0x237efb0)
[140541036951424]dynProcess.C[725]: findSignalhandler(0x237efb0): gettingSymbolInfo
[140541036951424]dynProcess.C[736]: leaving findSignalhandler(0x237efb0)
[140541036951424]dynProcess.C[665]: adding shared object libdyninstAPI_RT.so.9.3.2, addr range 0x7f45a83ff000 to 0x7f45a840493c
[140541036951424]mapped_object.C[151]:  about to parseImage
[140541036951424]mapped_object.C[153]: name /usr/local/lib64/libstdc++.so.6.0.20, codeBase 0x7f45a80f7000, dataBase 0x7f45a80f7000
[140541036951424]image.C[1220]:  about to create image
[140541036951424]image.C[1415]:  opening file /usr/local/lib64/libstdc++.so.6.0.20
[140541036951424]image.C[1506]:  before findMain
[140541036951424]image.C[1513]: findMain analysis succeeded.
[140541036951424]image.C[1544]:  before determineImageType
[140541036951424]image.C[1222]:  created image
[140541036951424]image.C[1225]: processing shared object
[140541036951424]mapped_object.C[200]:  creating mapped object
[140541036951424][mapped_object.C:105] Creating new mapped_object /usr/local/lib64/libstdc++.so.6.0.20/
[140541036951424][mapped_object.C:107] 	codeBase 0x7f45a80f7000, codeOffset 0x0, size 954508
[140541036951424][mapped_object.C:109] 	dataBase 0x7f45a80f7000, dataOffset 0x2e9130, size 38344
[140541036951424][mapped_object.C:111] 	fileDescriptor: code at 0x7f45a80f7000, data 0x7f45a80f7000
[140541036951424][mapped_object.C:113] 	Code: 0x7f45a80f7000 to 0x7f45a81e008c
[140541036951424][mapped_object.C:115] 	Data: 0x7f45a83e0130 to 0x7f45a83e96f8
[140541036951424]mapped_object.C[205]:  leaving createMappedObject(/usr/local/lib64/libstdc++.so.6.0.20)
[140541036951424]dynProcess.C[719]: findSignalhandler(0x2dfec00)
[140541036951424]dynProcess.C[725]: findSignalhandler(0x2dfec00): gettingSymbolInfo
[140541036951424]dynProcess.C[736]: leaving findSignalhandler(0x2dfec00)
[140541036951424]dynProcess.C[665]: adding shared object libstdc++.so.6.0.20, addr range 0x7f45a80f7000 to 0x7f45a81e008c
[140541036951424]mapped_object.C[151]:  about to parseImage
[140541036951424]mapped_object.C[153]: name /usr/lib64/libm-2.17.so, codeBase 0x7f45a7df5000, dataBase 0x7f45a7df5000
[140541036951424]image.C[1220]:  about to create image
[140541036951424]image.C[1415]:  opening file /usr/lib64/libm-2.17.so
[140541036951424]image.C[1506]:  before findMain
[140541036951424]image.C[1513]: findMain analysis succeeded.
[140541036951424]image.C[1544]:  before determineImageType
[140541036951424]image.C[1222]:  created image
[140541036951424]image.C[1225]: processing shared object
[140541036951424]mapped_object.C[200]:  creating mapped object
[140541036951424][mapped_object.C:105] Creating new mapped_object /usr/lib64/libm-2.17.so/
[140541036951424][mapped_object.C:107] 	codeBase 0x7f45a7df5000, codeOffset 0x0, size 1050496
[140541036951424][mapped_object.C:109] 	dataBase 0x7f45a7df5000, dataOffset 0x300d70, size 884
[140541036951424][mapped_object.C:111] 	fileDescriptor: code at 0x7f45a7df5000, data 0x7f45a7df5000
[140541036951424][mapped_object.C:113] 	Code: 0x7f45a7df5000 to 0x7f45a7ef5780
[140541036951424][mapped_object.C:115] 	Data: 0x7f45a80f5d70 to 0x7f45a80f60e4
[140541036951424]mapped_object.C[205]:  leaving createMappedObject(/usr/lib64/libm-2.17.so)
[140541036951424]dynProcess.C[719]: findSignalhandler(0x30641f0)
[140541036951424]dynProcess.C[725]: findSignalhandler(0x30641f0): gettingSymbolInfo
[140541036951424]dynProcess.C[736]: leaving findSignalhandler(0x30641f0)
[140541036951424]dynProcess.C[665]: adding shared object libm-2.17.so, addr range 0x7f45a7df5000 to 0x7f45a7ef5780
[140541036951424]mapped_object.C[151]:  about to parseImage
[140541036951424]mapped_object.C[153]: name /usr/local/lib64/libgcc_s.so.1, codeBase 0x7f45a7bde000, dataBase 0x7f45a7bde000
[140541036951424]image.C[1220]:  about to create image
[140541036951424]image.C[1415]:  opening file /usr/local/lib64/libgcc_s.so.1
[140541036951424]image.C[1506]:  before findMain
[140541036951424]image.C[1513]: findMain analysis succeeded.
[140541036951424]image.C[1544]:  before determineImageType
[140541036951424]image.C[1222]:  created image
[140541036951424]image.C[1225]: processing shared object
[140541036951424]mapped_object.C[200]:  creating mapped object
[140541036951424][mapped_object.C:105] Creating new mapped_object /usr/local/lib64/libgcc_s.so.1/
[140541036951424][mapped_object.C:107] 	codeBase 0x7f45a7bde000, codeOffset 0x0, size 86740
[140541036951424][mapped_object.C:109] 	dataBase 0x7f45a7bde000, dataOffset 0x215db8, size 960
[140541036951424][mapped_object.C:111] 	fileDescriptor: code at 0x7f45a7bde000, data 0x7f45a7bde000
[140541036951424][mapped_object.C:113] 	Code: 0x7f45a7bde000 to 0x7f45a7bf32d4
[140541036951424][mapped_object.C:115] 	Data: 0x7f45a7df3db8 to 0x7f45a7df4178
[140541036951424]mapped_object.C[205]:  leaving createMappedObject(/usr/local/lib64/libgcc_s.so.1)
[140541036951424]dynProcess.C[719]: findSignalhandler(0x313f4c0)
[140541036951424]dynProcess.C[725]: findSignalhandler(0x313f4c0): gettingSymbolInfo
[140541036951424]dynProcess.C[736]: leaving findSignalhandler(0x313f4c0)
[140541036951424]dynProcess.C[665]: adding shared object libgcc_s.so.1, addr range 0x7f45a7bde000 to 0x7f45a7bf32d4
[140541036951424]mapped_object.C[151]:  about to parseImage
[140541036951424]mapped_object.C[153]: name /usr/lib64/libc-2.17.so, codeBase 0x7f45a781b000, dataBase 0x7f45a781b000
[140541036951424]image.C[1220]:  about to create image
[140541036951424]image.C[1415]:  opening file /usr/lib64/libc-2.17.so
[140541036951424]image.C[1506]:  before findMain
[140541036951424]image.C[633]:  setting 64-bit mode
[140541036951424]image.C[728]:  try to visit  <xor>(<extract:1>(<extract:64>(<xor>(<extMSB>(<V([x86_64::rsp]:21d10)>,<65:64>,),<xor>(<extMSB>(<invert>(<8:64>,),<65:64>,),<add>(<extMSB>(<V([x86_64::rsp]:21d10)>,<65:64>,),<add>(<extMSB>(<invert>(<8:64>,),<65:64>,),<invert>(<0:1>,),),),),),<1:65>,<65:65>,),<63:64>,<64:64>,),<extract:1>(<extract:64>(<xor>(<extMSB>(<V([x86_64::rsp]:21d10)>,<65:64>,),<xor>(<extMSB>(<invert>(<8:64>,),<65:64>,),<add>(<extMSB>(<V([x86_64::rsp]:21d10)>,<65:64>,),<add>(<extMSB>(<invert>(<8:64>,),<65:64>,),<invert>(<0:1>,),),),),),<1:65>,<65:65>,),<62:64>,<63:64>,),)
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[446] unhandled FindMainVisitor operation
[140541036951424]image.C[736]:  FindMainVisitor cannot find main address in <xor>(<extract:1>(<extract:64>(<xor>(<extMSB>(<V([x86_64::rsp]:21d10)>,<65:64>,),<xor>(<extMSB>(<invert>(<8:64>,),<65:64>,),<add>(<extMSB>(<V([x86_64::rsp]:21d10)>,<65:64>,),<add>(<extMSB>(<invert>(<8:64>,),<65:64>,),<invert>(<0:1>,),),),),),<1:65>,<65:65>,),<63:64>,<64:64>,),<extract:1>(<extract:64>(<xor>(<extMSB>(<V([x86_64::rsp]:21d10)>,<65:64>,),<xor>(<extMSB>(<invert>(<8:64>,),<65:64>,),<add>(<extMSB>(<V([x86_64::rsp]:21d10)>,<65:64>,),<add>(<extMSB>(<invert>(<8:64>,),<65:64>,),<invert>(<0:1>,),),),),),<1:65>,<65:65>,),<62:64>,<63:64>,),)
[140541036951424]image.C[783]:  invalid main address 0x0
[140541036951424]image.C[1513]: findMain analysis succeeded.
[140541036951424]image.C[1544]:  before determineImageType
[140541036951424]image.C[1222]:  created image
[140541036951424]image.C[1225]: processing shared object
[140541036951424]mapped_object.C[200]:  creating mapped object
[140541036951424][mapped_object.C:105] Creating new mapped_object /usr/lib64/libc-2.17.so/
[140541036951424][mapped_object.C:107] 	codeBase 0x7f45a781b000, codeOffset 0x0, size 1801620
[140541036951424][mapped_object.C:109] 	dataBase 0x7f45a781b000, dataOffset 0x3b8730, size 20848
[140541036951424][mapped_object.C:111] 	fileDescriptor: code at 0x7f45a781b000, data 0x7f45a781b000
[140541036951424][mapped_object.C:113] 	Code: 0x7f45a781b000 to 0x7f45a79d2d94
[140541036951424][mapped_object.C:115] 	Data: 0x7f45a7bd3730 to 0x7f45a7bd88a0
[140541036951424]mapped_object.C[205]:  leaving createMappedObject(/usr/lib64/libc-2.17.so)
[140541036951424]dynProcess.C[719]: findSignalhandler(0x44b0a10)
[140541036951424]dynProcess.C[725]: findSignalhandler(0x44b0a10): gettingSymbolInfo
[140541036951424]dynProcess.C[732]: findSignalhandler(0x44b0a10): addingSignalHandler(0x7f45a7850270, 1)
[140541036951424]dynProcess.C[736]: leaving findSignalhandler(0x44b0a10)
[140541036951424]dynProcess.C[665]: adding shared object libc-2.17.so, addr range 0x7f45a781b000 to 0x7f45a79d2d94
[140541036951424]mapped_object.C[151]:  about to parseImage
[140541036951424]mapped_object.C[153]: name /usr/lib64/libdl-2.17.so, codeBase 0x7f45a7617000, dataBase 0x7f45a7617000
[140541036951424]image.C[1220]:  about to create image
[140541036951424]image.C[1415]:  opening file /usr/lib64/libdl-2.17.so
[140541036951424]image.C[1506]:  before findMain
[140541036951424]image.C[1513]: findMain analysis succeeded.
[140541036951424]image.C[1544]:  before determineImageType
[140541036951424]image.C[1222]:  created image
[140541036951424]image.C[1225]: processing shared object
[140541036951424]mapped_object.C[200]:  creating mapped object
[140541036951424][mapped_object.C:105] Creating new mapped_object /usr/lib64/libdl-2.17.so/
[140541036951424][mapped_object.C:107] 	codeBase 0x7f45a7617000, codeOffset 0x0, size 8152
[140541036951424][mapped_object.C:109] 	dataBase 0x7f45a7617000, dataOffset 0x202d58, size 832
[140541036951424][mapped_object.C:111] 	fileDescriptor: code at 0x7f45a7617000, data 0x7f45a7617000
[140541036951424][mapped_object.C:113] 	Code: 0x7f45a7617000 to 0x7f45a7618fd8
[140541036951424][mapped_object.C:115] 	Data: 0x7f45a7819d58 to 0x7f45a781a098
[140541036951424]mapped_object.C[205]:  leaving createMappedObject(/usr/lib64/libdl-2.17.so)
[140541036951424]dynProcess.C[719]: findSignalhandler(0x3c2db50)
[140541036951424]dynProcess.C[725]: findSignalhandler(0x3c2db50): gettingSymbolInfo
[140541036951424]dynProcess.C[736]: leaving findSignalhandler(0x3c2db50)
[140541036951424]dynProcess.C[665]: adding shared object libdl-2.17.so, addr range 0x7f45a7617000 to 0x7f45a7618fd8
[140541036951424]dynProcess.C[387]: waiting for main() loop
[140541036951424]dynProcess.C[389]: We think the process is stopped, continuing
[140541036951424]dynProcess.C[416]: bootstrap waiting for process to initialize
[140541036951424]pcEventMuxer.C[333]: removing breakpoint at main
[140541036951424]dynProcess.C[427]: process initialized, loading the RT library
[140541036951424]dynProcess.C[797]: RT library already loaded
[140541036951424]dynProcess.C[834]: DYNINSTinit succeeded
[140541036951424]dynProcess.C[841]: welcome to PCProcess::setRTLibInitParams
[140541036951424]dynProcess.C[454]: installing default Dyninst instrumentation into process 4201
[140541036951424]dynProcess.C[521]: finished bootstrapping process 4201
Registering function callback...
Registering instPoint callback...
Registering process...
Getting initial thread...
Creating new BPatch_image...
BPatch_process::BPatch_process, completed.
String = Hello world,  Address = 34291728
The number of times called to the same function was: 5
Enabling DyninstAPI startup debug
****************************************
*****    APPLICATION CONTROLLER    *****
*****    (c) 2001-2010, UAB        *****
****************************************
argc: 3
[CTRL] Reading config file: AC.ini, curDir: /home/aolmo/soft/XFire 
SYSLOG START
Enabling DyninstAPI startup debug
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] add a logger that writes to a file if its filename is specified
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] appendMachineName
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] Configuration taken from section: Syslog 3865
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [CTRL] Syslog configured
[AC      ] 25-04-2018 08:52:24  [INFO   ] AC ready on host aopccag.uab.es
[AC      ] 25-04-2018 08:52:24  [INFO   ] [TaskManager] Analyzer host is localhost, collector port 8800
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] PTPAcceptor base port AC is 9900
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] Process mpiRank: 1

[AC      ] 25-04-2018 08:52:24  [DEBUG  ] PTPAcceptor port AC is 9901
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [ServerSocket::ServerSocket] port: 9901
****************************************
*****    APPLICATION CONTROLLER    *****
*****    (c) 2001-2010, UAB        *****
****************************************
argc: 3
[CTRL] Reading config file: AC.ini, curDir: /home/aolmo/soft/XFire 
CTRL140588135155584
localhost
8800
SYSLOG START
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] add a logger that writes to a file if its filename is specified
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] appendMachineName
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] Configuration taken from section: Syslog 3864
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [CTRL] Syslog configured
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [ServerSocket::ServerSocket] binded
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] PTP accepted registering in reactor
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] Reactor -> register handler
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] Clock diff to time server: 0 [microsec]
[AC      ] 25-04-2018 08:52:24  [INFO   ] [TaskManager] start mpi task mpi
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [TaskManager] start task mpi
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [TaskManager] Arg 0=mpi
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [TaskManager] Arg 1=demo
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [TaskManager] starting task...
Creating process mpi in directory ./
Arguments: (2)
   0: mpi
   1: demo
Environment: (0)
[140588135155584]dynProcess.C[85]: stdin: 0, stdout: 1, stderr: 2
[AC      ] 25-04-2018 08:52:24  [INFO   ] AC ready on host aopccag.uab.es
[AC      ] 25-04-2018 08:52:24  [INFO   ] [TaskManager] Analyzer host is localhost, collector port 8800
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] PTPAcceptor base port AC is 9900
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] Process mpiRank: 0

[AC      ] 25-04-2018 08:52:24  [DEBUG  ] PTPAcceptor port AC is 9900
Failed to set environment var to preload RT library
--FATAL-- #68: Dyninst was unable to create the specified process
--FATAL-- #68: create process failed bootstrap
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [ServerSocket::ServerSocket] port: 9900
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [ServerSocket::ServerSocket] binded
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] PTP accepted registering in reactor
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] Reactor -> register handler
[AC      ] 25-04-2018 08:52:24  [INFO   ] Cleaning up tasks (0 tasks left)
[AC      ] 25-04-2018 08:52:24  [INFO   ] Clean up done
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] Controller exists
CTRL140571584620416
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] Clock diff to time server: 0 [microsec]
[AC      ] 25-04-2018 08:52:24  [INFO   ] [TaskManager] start mpi task mpi
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [TaskManager] start task mpi
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [TaskManager] Arg 0=mpi
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [TaskManager] Arg 1=demo
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] [TaskManager] starting task...
DynInst Exception: Process creation failed, Object name: mpi
SYSLOG END
localhost
8800
Creating process mpi in directory ./
Arguments: (2)
   0: mpi
   1: demo
Environment: (0)
[140571584620416]dynProcess.C[85]: stdin: 0, stdout: 1, stderr: 2
Failed to set environment var to preload RT library
--FATAL-- #68: Dyninst was unable to create the specified process
--FATAL-- #68: create process failed bootstrap
[AC      ] 25-04-2018 08:52:24  [INFO   ] Cleaning up tasks (0 tasks left)
[AC      ] 25-04-2018 08:52:24  [INFO   ] Clean up done
[AC      ] 25-04-2018 08:52:24  [DEBUG  ] Controller exists
DynInst Exception: Process creation failed, Object name: mpi
SYSLOG END
-------------------------------------------------------
Primary job  terminated normally, but 1 process returned
a non-zero exit code.. Per user-direction, the job has been aborted.
-------------------------------------------------------
--------------------------------------------------------------------------
mpirun detected that one or more processes exited with non-zero status, thus causing
the job to be terminated. The first process to do so was:

  Process name: [[55305,1],1]
  Exit code:    255
--------------------------------------------------------------------------
[← Prev in Thread] Current Thread [Next in Thread→]