Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr AixLib_AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.0008897/0.0008897, allocations: 84.23 kB / 20.06 MB, free: 4.465 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.0007878/0.0007878, allocations: 173.9 kB / 23.36 MB, free: 1.16 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.7942/0.7942, allocations: 177.1 MB / 203.7 MB, free: 5.699 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo): time 0.03214/0.03214, allocations: 9.116 MB / 269.2 MB, free: 4.426 MB / 250.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo): time 0.0002697/0.0002697, allocations: 26.58 kB / 328.7 MB, free: 20.57 MB / 266.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo): time 1.389/1.389, allocations: 275 MB / 0.6476 GB, free: 2.465 MB / 0.4949 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/EmbeddedTargets/STM32F4/Functions/HAL.mo:5:3-11:14:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/OperatingSystem/DynamicArray.mo:6:3-94:18:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1041:3-1062:27:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/Incubate/Utilities/Functions.mo:1064:3-1092:25:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 178]
Using package AixLib with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/AixLib 3.0.0/package.mo)
Using package SDF with version 0.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SDF master/package.mo)
Using package Modelica_DeviceDrivers with version 2.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.2.0/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="AixLib_AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains")
translateModel(AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="AixLib_AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.284e-05/2.284e-05, allocations: 2.312 kB / 0.9295 GB, free: 8.102 MB / 0.698 GB
Notification: Performance of NFInst.instantiate(AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains): time 0.00271/0.002733, allocations: 2.389 MB / 0.9318 GB, free: 5.727 MB / 0.698 GB
Notification: Performance of NFInst.instExpressions: time 0.002497/0.00523, allocations: 2.159 MB / 0.9339 GB, free: 3.555 MB / 0.698 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003774/0.005608, allocations: 19.88 kB / 0.9339 GB, free: 3.535 MB / 0.698 GB
Notification: Performance of NFTyping.typeComponents: time 0.000285/0.005893, allocations: 127.5 kB / 0.934 GB, free: 3.41 MB / 0.698 GB
Notification: Performance of NFTyping.typeBindings: time 0.0002401/0.006133, allocations: 153.2 kB / 0.9342 GB, free: 3.262 MB / 0.698 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00118/0.007313, allocations: 0.7428 MB / 0.9349 GB, free: 2.52 MB / 0.698 GB
Notification: Performance of NFFlatten.flatten: time 0.001099/0.008412, allocations: 1.391 MB / 0.9363 GB, free: 1.141 MB / 0.698 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0004532/0.008866, allocations: 321.2 kB / 0.9366 GB, free: 0.8047 MB / 0.698 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0006422/0.009508, allocations: 0.6979 MB / 0.9373 GB, free: 108 kB / 0.698 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003568/0.009865, allocations: 370.5 kB / 0.9376 GB, free: 15.75 MB / 0.7137 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001312/0.009996, allocations: 132 kB / 0.9377 GB, free: 15.62 MB / 0.7137 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001485/0.01014, allocations: 152.5 kB / 0.9379 GB, free: 15.47 MB / 0.7137 GB
Notification: Performance of combineBinaries: time 0.0007607/0.0109, allocations: 1.626 MB / 0.9395 GB, free: 13.83 MB / 0.7137 GB
Notification: Performance of replaceArrayConstructors: time 0.0003758/0.01128, allocations: 0.8988 MB / 0.9403 GB, free: 12.92 MB / 0.7137 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001148/0.0114, allocations: 75.75 kB / 0.9404 GB, free: 12.85 MB / 0.7137 GB
Notification: Performance of FrontEnd: time 0.0001315/0.01153, allocations: 51.5 kB / 0.9405 GB, free: 12.8 MB / 0.7137 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 169 (169)
 * Number of variables: 169 (169)
Notification: Performance of [SIM] Bindings: time 0.002385/0.01391, allocations: 4.252 MB / 0.9446 GB, free: 8.355 MB / 0.7137 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0003828/0.0143, allocations: 0.4992 MB / 0.9451 GB, free: 7.84 MB / 0.7137 GB
Notification: Performance of [SIM] Early Inline: time 0.001507/0.0158, allocations: 2.604 MB / 0.9477 GB, free: 5.195 MB / 0.7137 GB
Notification: Performance of [SIM] Simplify 1: time 0.0004626/0.01627, allocations: 0.5309 MB / 0.9482 GB, free: 4.625 MB / 0.7137 GB
Notification: Performance of [SIM] Alias: time 0.004156/0.02042, allocations: 4.389 MB / 0.9525 GB, free: 15.75 MB / 0.7293 GB
Notification: Performance of [SIM] Simplify 2: time 0.0003701/0.02079, allocations: 451 kB / 0.9529 GB, free: 15.29 MB / 0.7293 GB
Notification: Performance of [SIM] Remove Stream: time 0.0002755/0.02107, allocations: 438.5 kB / 0.9533 GB, free: 14.83 MB / 0.7293 GB
Notification: Performance of [SIM] Detect States: time 0.0006879/0.02175, allocations: 0.9074 MB / 0.9542 GB, free: 13.86 MB / 0.7293 GB
Notification: Performance of [SIM] Events: time 0.0001938/0.02195, allocations: 163.4 kB / 0.9543 GB, free: 13.7 MB / 0.7293 GB
Notification: Performance of [SIM] Partitioning: time 0.0004986/0.02245, allocations: 0.6583 MB / 0.955 GB, free: 12.99 MB / 0.7293 GB
Notification: Performance of [SIM] Causalize: time 0.0009021/0.02335, allocations: 1.099 MB / 0.9561 GB, free: 11.87 MB / 0.7293 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.001009/0.02436, allocations: 1.807 MB / 0.9578 GB, free: 10.06 MB / 0.7293 GB
Notification: Performance of [INI] Simplify: time 0.001409/0.02577, allocations: 1.536 MB / 0.9593 GB, free: 8.434 MB / 0.7293 GB
Notification: Performance of [INI] Inline: time 0.001376/0.02714, allocations: 2.525 MB / 0.9618 GB, free: 5.895 MB / 0.7293 GB
Notification: Performance of [INI] Partitioning: time 7.161e-05/0.02721, allocations: 60.05 kB / 0.9619 GB, free: 5.824 MB / 0.7293 GB
Notification: Performance of [INI] Cleanup: time 0.0007134/0.02793, allocations: 1.241 MB / 0.9631 GB, free: 4.57 MB / 0.7293 GB
Notification: Performance of [INI] Causalize: time 0.00486/0.03279, allocations: 5.764 MB / 0.9687 GB, free: 14.7 MB / 0.7449 GB
Notification: Performance of [INI] Tearing: time 7.275e-05/0.03286, allocations: 160 kB / 0.9688 GB, free: 14.54 MB / 0.7449 GB
Notification: Performance of [SIM] Initialization: time 1.914e-06/0.03286, allocations: 0 / 0.9688 GB, free: 14.54 MB / 0.7449 GB
Notification: Performance of [SIM] DAE-Mode: time 0.000295/0.03316, allocations: 272.4 kB / 0.9691 GB, free: 14.26 MB / 0.7449 GB
Notification: Performance of [SIM] Remove Dummies: time 6.041e-06/0.03316, allocations: 0.6562 kB / 0.9691 GB, free: 14.26 MB / 0.7449 GB
Notification: Performance of [SIM] Tearing: time 2.178e-05/0.03319, allocations: 68 kB / 0.9692 GB, free: 14.2 MB / 0.7449 GB
Notification: Performance of [SIM] Categorize: time 1.218e-05/0.0332, allocations: 4 kB / 0.9692 GB, free: 14.19 MB / 0.7449 GB
Notification: Performance of [SIM] Solve: time 0.001248/0.03445, allocations: 1.374 MB / 0.9705 GB, free: 12.81 MB / 0.7449 GB
Notification: Performance of [SIM] Jacobian: time 0.0006581/0.0351, allocations: 0.8392 MB / 0.9713 GB, free: 11.9 MB / 0.7449 GB
Notification: Performance of [SIM] Minimize Homotopy System: time 4.709e-06/0.03511, allocations: 0 / 0.9713 GB, free: 11.9 MB / 0.7449 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 1
 * Number of algebraic event partitions: ......... 1
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 1
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 4 (4) {PIDWitInpGai.addPID.u2, PIDWitInpGai.D.x, PID.addPID.u2, PID.D.x}
 * Number of discrete states: .................... 5 (5) {Td.booPul.y, Ti.booPul.y, k.booPul.y, resSig.y, pulse.booPul.y}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 20 (20) {PIDWitInpGai.greThrkTd.greHys.y, PIDWitInpGai.assMeskTd.u, lesThr.lesHys.y, or2.u1, or2.u2, or2.y, $SEV_2, $SEV_1, $SEV_0, $TEV_10, $TEV_9, $TEV_8, $TEV_7, $TEV_6, $TEV_5, $TEV_4, $TEV_3, $TEV_2, $TEV_1, $TEV_0}
 * Number of clocks: ............................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 67 (scalar:67, array:0, record:0)
 * Number of multi strong components: ............ 5 (algorithm:0, when:5, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 151 (scalar:151, array:0, record:0)
 * Number of multi strong components: ............ 5 (algorithm:5, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 151 (scalar:151, array:0, record:0)
 * Number of multi strong components: ............ 5 (algorithm:5, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 8.323e-05/0.03519, allocations: 100.2 kB / 0.9714 GB, free: 11.82 MB / 0.7449 GB
Notification: Performance of SimCode: time 0.002541/0.03773, allocations: 3.511 MB / 0.9749 GB, free: 8.219 MB / 0.7449 GB
Notification: Performance of Templates: time 0.009957/0.04769, allocations: 9.39 MB / 0.984 GB, free: 14.91 MB / 0.7605 GB
"
[Timeout remaining time 660]
make -j1 -f AixLib_AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains.makefile [Timeout 660]
(rm -f AixLib_AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains.pipe ; mkfifo AixLib_AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains.pipe ; head -c 1048576 < AixLib_AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains.pipe >> ../files/AixLib_AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains.sim & ./AixLib_AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains  -abortSlowSimulation -alarm=480 -lv LOG_STATS > AixLib_AixLib.Controls.OBC.Utilities.Validation.PIDWithInputGains.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 4.5697450498119]
Failed to read output from testmodel.py, exit status != 0:
0.05303983110934496 0.06008839499999994 0.04707768499999994
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x72397babc770>