Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0_Modelica.Fluid.Examples.InverseParameterization.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.001317/0.001317, allocations: 107.6 kB / 21.2 MB, free: 0.6641 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.001421/0.001421, allocations: 205.1 kB / 24.49 MB, free: 3.961 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.469/1.469, allocations: 230.6 MB / 258.3 MB, free: 7.801 MB / 206.1 MB
"
[Timeout remaining time 178]
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(Modelica.Fluid.Examples.InverseParameterization,tolerance=1e-06,outputFormat="mat",numberOfIntervals=10000,variableFilter="time|sink.ports.1..m_flow|sink1.ports.1..m_flow|sink2.ports.1..m_flow|pipe1.flowModel.dps_fg_turbulent.1.|pipe1.flowModel.pathLengths_nominal.1.|pipe2.flowModel.pathLengths_nominal.1.",fileNamePrefix="Modelica_4.1.0_Modelica.Fluid.Examples.InverseParameterization")
translateModel(Modelica.Fluid.Examples.InverseParameterization,tolerance=1e-06,outputFormat="mat",numberOfIntervals=10000,variableFilter="time|sink.ports.1..m_flow|sink1.ports.1..m_flow|sink2.ports.1..m_flow|pipe1.flowModel.dps_fg_turbulent.1.|pipe1.flowModel.pathLengths_nominal.1.|pipe2.flowModel.pathLengths_nominal.1.",fileNamePrefix="Modelica_4.1.0_Modelica.Fluid.Examples.InverseParameterization") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.96e-05/2.96e-05, allocations: 2.281 kB / 378.9 MB, free: 2.531 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.InverseParameterization): time 0.2614/0.2614, allocations: 65.97 MB / 444.9 MB, free: 11.35 MB / 350.1 MB
Notification: Performance of NFInst.instExpressions: time 0.03861/0.3, allocations: 22.48 MB / 467.4 MB, free: 4.809 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002205/0.3022, allocations: 59.44 kB / 467.4 MB, free: 4.75 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.003042/0.3053, allocations: 0.718 MB / 468.1 MB, free: 4.027 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.02296/0.3282, allocations: 6.472 MB / 474.6 MB, free: 13.56 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01457/0.3428, allocations: 4.464 MB / 479.1 MB, free: 9.098 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0082/0.351, allocations: 5.203 MB / 484.3 MB, free: 3.883 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002817/0.3538, allocations: 1.33 MB / 485.6 MB, free: 2.543 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005524/0.3593, allocations: 2.298 MB / 487.9 MB, free: 244 kB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0198/0.3791, allocations: 9.519 MB / 497.4 MB, free: 6.582 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0006249/0.3798, allocations: 156 kB / 497.6 MB, free: 6.43 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02029/0.4, allocations: 9.563 MB / 0.4953 GB, free: 12.83 MB / 414.1 MB
Notification: Performance of combineBinaries: time 0.004877/0.4049, allocations: 3.919 MB / 0.4991 GB, free: 8.883 MB / 414.1 MB
Notification: Performance of replaceArrayConstructors: time 0.002121/0.407, allocations: 2.164 MB / 0.5012 GB, free: 6.695 MB / 414.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004816/0.4075, allocations: 152 kB / 0.5013 GB, free: 6.547 MB / 414.1 MB
Notification: Performance of FrontEnd: time 0.0004123/0.4079, allocations: 51.78 kB / 0.5014 GB, free: 6.496 MB / 414.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 287 (235)
 * Number of variables: 287 (263)
Notification: Performance of [SIM] Bindings: time 0.01069/0.4186, allocations: 9.203 MB / 0.5104 GB, free: 13.03 MB / 430.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.00164/0.4203, allocations: 1.246 MB / 0.5116 GB, free: 11.73 MB / 430.1 MB
Notification: Performance of [SIM] Early Inline: time 0.009856/0.4301, allocations: 7.564 MB / 0.519 GB, free: 4.09 MB / 430.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.002411/0.4325, allocations: 1.171 MB / 0.5201 GB, free: 2.816 MB / 430.1 MB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.008282/0.4408, allocations: 5.055 MB / 0.5251 GB, free: 13.29 MB / 446.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.001766/0.4426, allocations: 1.089 MB / 0.5261 GB, free: 12.14 MB / 446.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0009823/0.4436, allocations: 0.7841 MB / 0.5269 GB, free: 11.32 MB / 446.1 MB
Notification: Performance of [SIM] Detect States: time 0.001305/0.4449, allocations: 1.21 MB / 0.5281 GB, free: 10.05 MB / 446.1 MB
Notification: Performance of [SIM] Events: time 0.001097/0.446, allocations: 0.7232 MB / 0.5288 GB, free: 9.359 MB / 446.1 MB
Notification: Performance of [SIM] Partitioning: time 0.003045/0.449, allocations: 2.501 MB / 0.5312 GB, free: 6.645 MB / 446.1 MB
Notification: Performance of [SIM] Causalize: time 0.0097/0.4587, allocations: 5.796 MB / 0.5369 GB, free: 0.6055 MB / 446.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.2807/0.7394, allocations: 5.611 MB / 0.5424 GB, free: 57.05 MB / 446.1 MB
Notification: Performance of [INI] Simplify: time 0.00647/0.7459, allocations: 2.639 MB / 0.5449 GB, free: 56.54 MB / 446.1 MB
Notification: Performance of [INI] Inline: time 0.01481/0.7607, allocations: 9.654 MB / 0.5544 GB, free: 56.41 MB / 446.1 MB
Notification: Performance of [INI] Partitioning: time 0.0005133/0.7612, allocations: 103.4 kB / 0.5545 GB, free: 56.34 MB / 446.1 MB
Notification: Performance of [INI] Cleanup: time 0.002913/0.7641, allocations: 1.721 MB / 0.5561 GB, free: 56.3 MB / 446.1 MB
Notification: Performance of [INI] Causalize: time 0.01862/0.7827, allocations: 13.88 MB / 0.5697 GB, free: 55.38 MB / 446.1 MB
Notification: Performance of [INI] Tearing: time 0.001969/0.7847, allocations: 1.792 MB / 0.5714 GB, free: 55 MB / 446.1 MB
Notification: Performance of [SIM] Initialization: time 2.294e-06/0.7847, allocations: 0 / 0.5714 GB, free: 55 MB / 446.1 MB
Notification: Performance of [SIM] Remove Dummies: time 4.528e-05/0.7848, allocations: 8.969 kB / 0.5715 GB, free: 55 MB / 446.1 MB
Notification: Performance of [SIM] Tearing: time 0.00111/0.7859, allocations: 0.9206 MB / 0.5724 GB, free: 54.78 MB / 446.1 MB
Notification: Performance of [SIM] Categorize: time 4.95e-05/0.7859, allocations: 10.44 kB / 0.5724 GB, free: 54.78 MB / 446.1 MB
Notification: Performance of [SIM] Solve: time 0.007682/0.7936, allocations: 5.718 MB / 0.5779 GB, free: 54.25 MB / 446.1 MB
Notification: Performance of [SIM] Jacobian: time 0.0174/0.811, allocations: 22.84 MB / 0.6002 GB, free: 36.96 MB / 446.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 11
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 15
 * 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: ............................. 0 (0) {}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 51 (49) {source.medium.state.phase, source.medium.phase, pump.medium.state.phase, pump.medium.phase, pump.heatTransfer.states.phase, pump.monitoring.state_in.phase, pump.monitoring.state.phase, orifice.state_a.phase, orifice.state_b.phase, sink.medium.state.phase, sink.medium.phase, pipe1.flowModel.states.phase, sink1.medium.state.phase, sink1.medium.phase, pipe2.flowModel.states.phase, sink2.medium.state.phase, sink2.medium.phase, $SEV_29, $SEV_28, $SEV_27, $SEV_26, $SEV_25, $SEV_24, $SEV_23, $SEV_22, $SEV_21, $SEV_20, $SEV_19, $SEV_18, $SEV_17, $SEV_16, $SEV_15, $SEV_14, $SEV_13, $SEV_12, $SEV_11, $SEV_10, $SEV_9, $SEV_8, $SEV_7, $SEV_6, $SEV_5, $SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $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: ........... 203 (scalar:196, array:7, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:2)
 * Number of for-loop strong components: ......... 3 (resizable: 3, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 2 (linear: 2, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 264 (scalar:253, array:11, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:2)
 * Number of for-loop strong components: ......... 3 (resizable: 3, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 2 (linear: 2, nonlinear:0)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 290 (scalar:277, array:13, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:2)
 * Number of for-loop strong components: ......... 5 (resizable: 5, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: Performance of backend: time 0.0002132/0.8112, allocations: 154.2 kB / 0.6004 GB, free: 36.82 MB / 446.1 MB
Notification: Performance of SimCode: time 0.0405/0.8517, allocations: 23.77 MB / 0.6236 GB, free: 17.72 MB / 446.1 MB
Notification: Performance of Templates: time 0.1235/0.9753, allocations: 93.37 MB / 0.7148 GB, free: 4.449 MB / 0.5137 GB
"
[Timeout remaining time 659]
make -j1 -f Modelica_4.1.0_Modelica.Fluid.Examples.InverseParameterization.makefile [Timeout 660]
(rm -f Modelica_4.1.0_Modelica.Fluid.Examples.InverseParameterization.pipe ; mkfifo Modelica_4.1.0_Modelica.Fluid.Examples.InverseParameterization.pipe ; head -c 1048576 < Modelica_4.1.0_Modelica.Fluid.Examples.InverseParameterization.pipe >> ../files/Modelica_4.1.0_Modelica.Fluid.Examples.InverseParameterization.sim & ./Modelica_4.1.0_Modelica.Fluid.Examples.InverseParameterization  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Modelica_4.1.0_Modelica.Fluid.Examples.InverseParameterization.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 8.494367368984967]
Failed to read output from testmodel.py, exit status != 0:
['time', 'sink.ports[1].m_flow', 'sink1.ports[1].m_flow', 'sink2.ports[1].m_flow', 'pipe1.flowModel.dps_fg_turbulent[1]', 'pipe1.flowModel.pathLengths_nominal[1]', 'pipe2.flowModel.pathLengths_nominal[1]']
0.9838800043798983 0.99828163 0.58705218
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff1ffdaef20>