Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IndustrialControlSystems_IndustrialControlSystems.LinearSystems.Examples.Basic.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.001535/0.001535, allocations: 104.3 kB / 19.77 MB, free: 2.051 MB / 14.72 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.001504/0.001504, allocations: 217.7 kB / 23.07 MB, free: 4.844 MB / 14.72 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 1.479/1.479, allocations: 230.7 MB / 256.9 MB, free: 7.715 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IndustrialControlSystems 2.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IndustrialControlSystems 2.0.0/package.mo): time 0.06202/0.06202, allocations: 11.34 MB / 324.6 MB, free: 7.969 MB / 254.1 MB
"
[Timeout remaining time 180]
Using package IndustrialControlSystems with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IndustrialControlSystems 2.0.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(IndustrialControlSystems.LinearSystems.Examples.Basic,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IndustrialControlSystems_IndustrialControlSystems.LinearSystems.Examples.Basic")
translateModel(IndustrialControlSystems.LinearSystems.Examples.Basic,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IndustrialControlSystems_IndustrialControlSystems.LinearSystems.Examples.Basic") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.384e-05/2.384e-05, allocations: 2.281 kB / 452.3 MB, free: 9.812 MB / 318.1 MB
Notification: Performance of NFInst.instantiate(IndustrialControlSystems.LinearSystems.Examples.Basic): time 0.003276/0.0033, allocations: 1.804 MB / 454.1 MB, free: 7.996 MB / 318.1 MB
Notification: Performance of NFInst.instExpressions: time 0.00125/0.004551, allocations: 0.5409 MB / 454.6 MB, free: 7.453 MB / 318.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 8.427e-05/0.004635, allocations: 4 kB / 454.6 MB, free: 7.449 MB / 318.1 MB
Notification: Performance of NFTyping.typeComponents: time 5.686e-05/0.004692, allocations: 23.67 kB / 454.7 MB, free: 7.426 MB / 318.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0001509/0.004843, allocations: 39.61 kB / 454.7 MB, free: 7.387 MB / 318.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0005399/0.005382, allocations: 183.5 kB / 454.9 MB, free: 7.207 MB / 318.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0002888/0.005671, allocations: 239.4 kB / 455.1 MB, free: 6.973 MB / 318.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0001694/0.005841, allocations: 48.5 kB / 455.2 MB, free: 6.926 MB / 318.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0001439/0.005985, allocations: 107.4 kB / 455.3 MB, free: 6.82 MB / 318.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001361/0.006121, allocations: 91.47 kB / 455.4 MB, free: 6.73 MB / 318.1 MB
Notification: Performance of NFPackage.collectConstants: time 3.881e-05/0.006159, allocations: 16 kB / 455.4 MB, free: 6.715 MB / 318.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0002272/0.006387, allocations: 151.8 kB / 455.5 MB, free: 6.566 MB / 318.1 MB
Notification: Performance of combineBinaries: time 0.0003729/0.006759, allocations: 439.1 kB / 455.9 MB, free: 6.133 MB / 318.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0001973/0.006957, allocations: 288.1 kB / 456.2 MB, free: 5.848 MB / 318.1 MB
Notification: Performance of NFVerifyModel.verify: time 3.406e-05/0.006991, allocations: 12 kB / 456.2 MB, free: 5.836 MB / 318.1 MB
Notification: Performance of FrontEnd: time 3.09e-05/0.007022, allocations: 7.938 kB / 456.2 MB, free: 5.828 MB / 318.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 25 (25)
 * Number of variables: 25 (25)
Notification: Performance of [SIM] Bindings: time 0.001254/0.008275, allocations: 1.135 MB / 457.4 MB, free: 4.566 MB / 318.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0001281/0.008403, allocations: 101.2 kB / 457.5 MB, free: 4.453 MB / 318.1 MB
Notification: Performance of [SIM] Early Inline: time 0.0004441/0.008847, allocations: 453.2 kB / 457.9 MB, free: 3.984 MB / 318.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0002032/0.009051, allocations: 129.9 kB / 458 MB, free: 3.809 MB / 318.1 MB
Notification: Performance of [SIM] Alias: time 0.0009574/0.01001, allocations: 0.6065 MB / 458.7 MB, free: 3.117 MB / 318.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0001648/0.01017, allocations: 124.5 kB / 458.8 MB, free: 2.949 MB / 318.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0001062/0.01028, allocations: 88.31 kB / 458.9 MB, free: 2.836 MB / 318.1 MB
Notification: Performance of [SIM] Detect States: time 0.000375/0.01065, allocations: 251.1 kB / 459.1 MB, free: 2.535 MB / 318.1 MB
Notification: Performance of [SIM] Events: time 0.0002004/0.01085, allocations: 106.2 kB / 459.2 MB, free: 2.43 MB / 318.1 MB
Notification: Performance of [SIM] Partitioning: time 0.0003347/0.01119, allocations: 256.4 kB / 459.5 MB, free: 2.141 MB / 318.1 MB
Notification: Performance of [SIM] Causalize: time 0.0005618/0.01175, allocations: 390.3 kB / 459.8 MB, free: 1.727 MB / 318.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0004418/0.01219, allocations: 459.6 kB / 460.3 MB, free: 1.277 MB / 318.1 MB
Notification: Performance of [INI] Simplify: time 0.0008602/0.01305, allocations: 0.545 MB / 460.8 MB, free: 0.6602 MB / 318.1 MB
Notification: Performance of [INI] Inline: time 0.0006401/0.01369, allocations: 0.6401 MB / 461.5 MB, free: 12 kB / 318.1 MB
Notification: Performance of [INI] Partitioning: time 6.631e-05/0.01376, allocations: 32.27 kB / 461.5 MB, free: 15.97 MB / 334.1 MB
Notification: Performance of [INI] Cleanup: time 0.0001042/0.01386, allocations: 115.9 kB / 461.6 MB, free: 15.86 MB / 334.1 MB
Notification: Performance of [INI] Causalize: time 0.0023/0.01616, allocations: 1.65 MB / 463.3 MB, free: 14.19 MB / 334.1 MB
Notification: Performance of [INI] Tearing: time 3.48e-05/0.0162, allocations: 36 kB / 463.3 MB, free: 14.15 MB / 334.1 MB
Notification: Performance of [SIM] Initialization: time 4.91e-07/0.0162, allocations: 0 / 463.3 MB, free: 14.15 MB / 334.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.0001917/0.01639, allocations: 132.5 kB / 463.4 MB, free: 13.98 MB / 334.1 MB
Notification: Performance of [SIM] Remove Dummies: time 5.67e-06/0.0164, allocations: 0 / 463.4 MB, free: 13.98 MB / 334.1 MB
Notification: Performance of [SIM] Tearing: time 1.546e-05/0.01641, allocations: 20 kB / 463.5 MB, free: 13.96 MB / 334.1 MB
Notification: Performance of [SIM] Categorize: time 1.689e-05/0.01643, allocations: 7.938 kB / 463.5 MB, free: 13.96 MB / 334.1 MB
Notification: Performance of [SIM] Solve: time 0.0007438/0.01717, allocations: 0.4923 MB / 464 MB, free: 13.46 MB / 334.1 MB
Notification: Performance of [SIM] Jacobian: time 0.0004335/0.01761, allocations: 444 kB / 464.4 MB, free: 12.96 MB / 334.1 MB
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: ......... 4
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 5 (5) {int.y, fO.y, lLag.dy, complexPoles.y, complexPoles.dy}
 * Number of discrete states: .................... 6 (6) {complexPoles_dig.y_pre1, complexPoles_dig.u_pre1, complexPoles_dig.y, lLag_dig.y, fO_dig.y, int_dig.y}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 11 (11) {$SEV_3, $SEV_2, $SEV_1, $SEV_0, $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: ........... 22 (scalar:22, array:0, record:0)
 * Number of multi strong components: ............ 6 (algorithm:0, when:6, 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: ........... 77 (scalar:77, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, 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 0.0001404/0.01775, allocations: 47.44 kB / 464.4 MB, free: 12.92 MB / 334.1 MB
Notification: Performance of SimCode: time 0.001499/0.01925, allocations: 1.013 MB / 465.4 MB, free: 11.89 MB / 334.1 MB
Notification: Performance of Templates: time 0.007098/0.02634, allocations: 3.011 MB / 468.5 MB, free: 8.906 MB / 334.1 MB
"
[Timeout remaining time 660]
make -j1 -f IndustrialControlSystems_IndustrialControlSystems.LinearSystems.Examples.Basic.makefile [Timeout 660]
(rm -f IndustrialControlSystems_IndustrialControlSystems.LinearSystems.Examples.Basic.pipe ; mkfifo IndustrialControlSystems_IndustrialControlSystems.LinearSystems.Examples.Basic.pipe ; head -c 1048576 < IndustrialControlSystems_IndustrialControlSystems.LinearSystems.Examples.Basic.pipe >> ../files/IndustrialControlSystems_IndustrialControlSystems.LinearSystems.Examples.Basic.sim & ./IndustrialControlSystems_IndustrialControlSystems.LinearSystems.Examples.Basic  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IndustrialControlSystems_IndustrialControlSystems.LinearSystems.Examples.Basic.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 4.511239233950619]
Failed to read output from testmodel.py, exit status != 0:
0.034786208998411894 0.049086118000000005 0.0391738
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f190dd36fb0>