Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.0.0_Modelica.Fluid.Examples.InverseParameterization.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001814/0.001814, allocations: 95.95 kB / 21.23 MB, free: 0.582 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00202/0.00202, allocations: 185.1 kB / 24.52 MB, free: 3.863 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.42/1.42, allocations: 225.7 MB / 253.3 MB, free: 12.8 MB / 206.1 MB
"
[Timeout remaining time 178]
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.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.0.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.0.0_Modelica.Fluid.Examples.InverseParameterization") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.334e-05/2.334e-05, allocations: 2.281 kB / 371.7 MB, free: 9.195 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.InverseParameterization): time 0.2373/0.2373, allocations: 65.76 MB / 437.4 MB, free: 5.047 MB / 334.1 MB
Notification: Performance of NFInst.instExpressions: time 0.03254/0.2699, allocations: 22.48 MB / 459.9 MB, free: 14.51 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001923/0.2718, allocations: 55.5 kB / 459.9 MB, free: 14.45 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.002422/0.2742, allocations: 0.7141 MB / 460.7 MB, free: 13.73 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01892/0.2932, allocations: 6.451 MB / 467.1 MB, free: 7.281 MB / 366.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01229/0.3054, allocations: 4.447 MB / 471.6 MB, free: 2.844 MB / 366.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007944/0.3134, allocations: 5.171 MB / 476.7 MB, free: 13.66 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002778/0.3162, allocations: 1.326 MB / 478.1 MB, free: 12.32 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004821/0.321, allocations: 2.29 MB / 480.3 MB, free: 10.02 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.02265/0.3436, allocations: 9.453 MB / 489.8 MB, free: 440 kB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0006604/0.3443, allocations: 152 kB / 489.9 MB, free: 288 kB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01954/0.3638, allocations: 9.235 MB / 499.2 MB, free: 7.012 MB / 398.1 MB
Notification: Performance of combineBinaries: time 0.005764/0.3696, allocations: 3.92 MB / 0.4913 GB, free: 3.062 MB / 398.1 MB
Notification: Performance of replaceArrayConstructors: time 0.002861/0.3725, allocations: 2.16 MB / 0.4934 GB, free: 0.8789 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0006715/0.3731, allocations: 152 kB / 0.4936 GB, free: 0.7305 MB / 398.1 MB
Notification: Performance of FrontEnd: time 0.0003848/0.3735, allocations: 47.86 kB / 0.4936 GB, free: 0.6836 MB / 398.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.01206/0.3856, allocations: 9.191 MB / 0.5026 GB, free: 7.23 MB / 414.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.001983/0.3876, allocations: 1.258 MB / 0.5038 GB, free: 5.938 MB / 414.1 MB
Notification: Performance of [SIM] Early Inline: time 0.01216/0.3997, allocations: 9.056 MB / 0.5127 GB, free: 12.8 MB / 430.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.002511/0.4022, allocations: 1.154 MB / 0.5138 GB, free: 11.54 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.008658/0.4109, allocations: 5.324 MB / 0.519 GB, free: 5.75 MB / 430.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.002015/0.4129, allocations: 1.098 MB / 0.5201 GB, free: 4.598 MB / 430.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.001361/0.4143, allocations: 0.9391 MB / 0.521 GB, free: 3.625 MB / 430.1 MB
Notification: Performance of [SIM] Detect States: time 0.001614/0.4159, allocations: 1.347 MB / 0.5223 GB, free: 2.215 MB / 430.1 MB
Notification: Performance of [SIM] Events: time 0.00125/0.4171, allocations: 0.7528 MB / 0.523 GB, free: 1.484 MB / 430.1 MB
Notification: Performance of [SIM] Partitioning: time 0.003553/0.4207, allocations: 2.739 MB / 0.5257 GB, free: 14.53 MB / 446.1 MB
Notification: Performance of [SIM] Causalize: time 0.01002/0.4307, allocations: 5.822 MB / 0.5314 GB, free: 8.461 MB / 446.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.007559/0.4383, allocations: 6.128 MB / 0.5374 GB, free: 2.332 MB / 446.1 MB
Notification: Performance of [INI] Simplify: time 0.2479/0.6862, allocations: 2.555 MB / 0.5399 GB, free: 63.52 MB / 446.1 MB
Notification: Performance of [INI] Inline: time 0.01389/0.7001, allocations: 8.036 MB / 0.5477 GB, free: 63.49 MB / 446.1 MB
Notification: Performance of [INI] Partitioning: time 0.000555/0.7006, allocations: 102.7 kB / 0.5478 GB, free: 63.43 MB / 446.1 MB
Notification: Performance of [INI] Cleanup: time 0.003829/0.7044, allocations: 1.568 MB / 0.5493 GB, free: 63.39 MB / 446.1 MB
Notification: Performance of [INI] Causalize: time 0.0281/0.7325, allocations: 13.53 MB / 0.5626 GB, free: 62.49 MB / 446.1 MB
Notification: Performance of [INI] Tearing: time 0.002134/0.7347, allocations: 1.699 MB / 0.5642 GB, free: 62.16 MB / 446.1 MB
Notification: Performance of [SIM] Initialization: time 2.695e-06/0.7347, allocations: 3.969 kB / 0.5642 GB, free: 62.16 MB / 446.1 MB
Notification: Performance of [SIM] Remove Dummies: time 4.752e-05/0.7347, allocations: 9.781 kB / 0.5642 GB, free: 62.16 MB / 446.1 MB
Notification: Performance of [SIM] Tearing: time 0.001107/0.7358, allocations: 0.8642 MB / 0.5651 GB, free: 62.02 MB / 446.1 MB
Notification: Performance of [SIM] Categorize: time 6.319e-05/0.7359, allocations: 20.31 kB / 0.5651 GB, free: 62.02 MB / 446.1 MB
Notification: Performance of [SIM] Solve: time 0.007343/0.7432, allocations: 4.91 MB / 0.5699 GB, free: 61.68 MB / 446.1 MB
Notification: Performance of [SIM] Jacobian: time 0.02176/0.765, allocations: 25.12 MB / 0.5944 GB, free: 43.26 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: ........... 204 (scalar:197, 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: ........... 265 (scalar:254, 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: ........... 291 (scalar:278, 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.0002341/0.7652, allocations: 154.5 kB / 0.5946 GB, free: 43.12 MB / 446.1 MB
Notification: Performance of SimCode: time 0.04991/0.8151, allocations: 23.52 MB / 0.6175 GB, free: 30.24 MB / 446.1 MB
Notification: Performance of Templates: time 0.1326/0.9477, allocations: 91.12 MB / 0.7065 GB, free: 3.395 MB / 0.4981 GB
"
[Timeout remaining time 659]
make -j1 -f Modelica_4.0.0_Modelica.Fluid.Examples.InverseParameterization.makefile [Timeout 660]
(rm -f Modelica_4.0.0_Modelica.Fluid.Examples.InverseParameterization.pipe ; mkfifo Modelica_4.0.0_Modelica.Fluid.Examples.InverseParameterization.pipe ; head -c 1048576 < Modelica_4.0.0_Modelica.Fluid.Examples.InverseParameterization.pipe >> ../files/Modelica_4.0.0_Modelica.Fluid.Examples.InverseParameterization.sim & ./Modelica_4.0.0_Modelica.Fluid.Examples.InverseParameterization  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Modelica_4.0.0_Modelica.Fluid.Examples.InverseParameterization.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 8.63270996324718]
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.9564294940792024 0.971011341 0.5939148820000001
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fb7c7bc2f20>