Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_3.2.3_Modelica.Thermal.FluidHeatFlow.Examples.TwoMass.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.001462/0.001462, allocations: 110.2 kB / 22 MB, free: 5.219 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.00159/0.00159, allocations: 214 kB / 25.3 MB, free: 2.898 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.688/1.688, allocations: 207.7 MB / 236.2 MB, free: 9.785 MB / 190.1 MB
"
[Timeout remaining time 178]
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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.Thermal.FluidHeatFlow.Examples.TwoMass,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="time|heatCapacitor1.T|heatCapacitor2.T|pipe1.T|pipe2.T|pipe3.T",fileNamePrefix="Modelica_3.2.3_Modelica.Thermal.FluidHeatFlow.Examples.TwoMass")
translateModel(Modelica.Thermal.FluidHeatFlow.Examples.TwoMass,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="time|heatCapacitor1.T|heatCapacitor2.T|pipe1.T|pipe2.T|pipe3.T",fileNamePrefix="Modelica_3.2.3_Modelica.Thermal.FluidHeatFlow.Examples.TwoMass") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 3.958e-05/3.958e-05, allocations: 2.281 kB / 348.5 MB, free: 9.383 MB / 286.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Thermal.FluidHeatFlow.Examples.TwoMass): time 0.01127/0.01131, allocations: 4.498 MB / 353 MB, free: 4.852 MB / 286.1 MB
Notification: Performance of NFInst.instExpressions: time 0.00422/0.01553, allocations: 1.286 MB / 354.3 MB, free: 3.559 MB / 286.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001079/0.01661, allocations: 15.88 kB / 354.3 MB, free: 3.543 MB / 286.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001006/0.01761, allocations: 166.6 kB / 354.5 MB, free: 3.379 MB / 286.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.001563/0.01918, allocations: 333.2 kB / 354.8 MB, free: 3.051 MB / 286.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0008997/0.02008, allocations: 219.6 kB / 355 MB, free: 2.836 MB / 286.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002667/0.02274, allocations: 1.371 MB / 356.4 MB, free: 1.461 MB / 286.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0006167/0.02336, allocations: 190.9 kB / 356.6 MB, free: 1.277 MB / 286.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001279/0.02464, allocations: 0.4904 MB / 357.1 MB, free: 0.7852 MB / 286.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0009259/0.02557, allocations: 457.8 kB / 357.5 MB, free: 344 kB / 286.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.000167/0.02573, allocations: 92 kB / 357.6 MB, free: 252 kB / 286.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.000281/0.02601, allocations: 116 kB / 357.7 MB, free: 136 kB / 286.1 MB
Notification: Performance of combineBinaries: time 0.002031/0.02804, allocations: 1.981 MB / 359.7 MB, free: 14.13 MB / 302.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0009731/0.02902, allocations: 1.184 MB / 360.9 MB, free: 12.93 MB / 302.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0002351/0.02925, allocations: 100 kB / 361 MB, free: 12.84 MB / 302.1 MB
Notification: Performance of FrontEnd: time 0.0001451/0.0294, allocations: 19.94 kB / 361 MB, free: 12.82 MB / 302.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 137 (137)
 * Number of variables: 137 (137)
Notification: Performance of [SIM] Bindings: time 0.005847/0.03524, allocations: 5.445 MB / 366.4 MB, free: 7.16 MB / 302.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0007855/0.03603, allocations: 0.5208 MB / 367 MB, free: 6.621 MB / 302.1 MB
Notification: Performance of [SIM] Early Inline: time 0.002417/0.03845, allocations: 2.182 MB / 369.1 MB, free: 4.398 MB / 302.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.001163/0.03961, allocations: 0.6965 MB / 369.8 MB, free: 3.629 MB / 302.1 MB
Notification: Performance of [SIM] Alias: time 0.005031/0.04464, allocations: 3.266 MB / 373.1 MB, free: 12 kB / 302.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0008902/0.04553, allocations: 0.565 MB / 373.7 MB, free: 15.39 MB / 318.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0003453/0.04588, allocations: 309.2 kB / 374 MB, free: 15.06 MB / 318.1 MB
Notification: Performance of [SIM] Detect States: time 0.0008275/0.04671, allocations: 0.6498 MB / 374.6 MB, free: 14.35 MB / 318.1 MB
Notification: Performance of [SIM] Events: time 0.0007532/0.04746, allocations: 0.5002 MB / 375.1 MB, free: 13.84 MB / 318.1 MB
Notification: Performance of [SIM] Partitioning: time 0.001603/0.04906, allocations: 1.249 MB / 376.4 MB, free: 12.35 MB / 318.1 MB
Notification: Performance of [SIM] Causalize: time 0.00309/0.05215, allocations: 2.186 MB / 378.6 MB, free: 9.926 MB / 318.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.002487/0.05464, allocations: 2.199 MB / 380.8 MB, free: 7.727 MB / 318.1 MB
Notification: Performance of [INI] Simplify: time 0.002494/0.05713, allocations: 1.322 MB / 382.1 MB, free: 6.293 MB / 318.1 MB
Notification: Performance of [INI] Inline: time 0.00308/0.06021, allocations: 2.974 MB / 385.1 MB, free: 3.305 MB / 318.1 MB
Notification: Performance of [INI] Partitioning: time 0.0001438/0.06036, allocations: 68.05 kB / 385.1 MB, free: 3.227 MB / 318.1 MB
Notification: Performance of [INI] Cleanup: time 0.0005339/0.06089, allocations: 0.4916 MB / 385.6 MB, free: 2.734 MB / 318.1 MB
Notification: Performance of [INI] Causalize: time 0.2447/0.3056, allocations: 6.334 MB / 391.9 MB, free: 35.76 MB / 318.1 MB
Notification: Performance of [INI] Tearing: time 0.000928/0.3065, allocations: 0.5799 MB / 392.5 MB, free: 35.7 MB / 318.1 MB
Notification: Performance of [SIM] Initialization: time 1.744e-06/0.3065, allocations: 2 kB / 392.5 MB, free: 35.7 MB / 318.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.001121/0.3077, allocations: 0.8783 MB / 393.4 MB, free: 35.16 MB / 318.1 MB
Notification: Performance of [SIM] Remove Dummies: time 2.541e-05/0.3077, allocations: 11.67 kB / 393.4 MB, free: 35.15 MB / 318.1 MB
Notification: Performance of [SIM] Tearing: time 0.0006065/0.3083, allocations: 466.4 kB / 393.9 MB, free: 35.05 MB / 318.1 MB
Notification: Performance of [SIM] Categorize: time 5.106e-05/0.3083, allocations: 15.83 kB / 393.9 MB, free: 35.05 MB / 318.1 MB
Notification: Performance of [SIM] Solve: time 0.004273/0.3126, allocations: 2.385 MB / 396.3 MB, free: 34.86 MB / 318.1 MB
Notification: Performance of [SIM] Jacobian: time 0.005115/0.3177, allocations: 4.43 MB / 400.7 MB, free: 32.1 MB / 318.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: ......... 30
 * 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) {dTMass1, dTMass2, pipe1.T, pipe2.T, pipe3.T}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 44 (44) {$FUN_2, $FUN_5, $FUN_8, $FUN_11, $SEV_35, $SEV_34, $SEV_33, $SEV_32, $SEV_31, $SEV_30, $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_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: ........... 87 (scalar:87, 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: ... 4 (linear: 4, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 118 (scalar:118, array:0, record:0)
 * Number of multi strong components: ............ 3 (algorithm:3, when:0, if:0, tuple:16)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 4 (linear: 4, nonlinear:0)
Notification: Performance of backend: time 0.0001186/0.3179, allocations: 70.25 kB / 400.8 MB, free: 32.05 MB / 318.1 MB
Notification: Performance of SimCode: time 0.005062/0.3229, allocations: 3.84 MB / 404.6 MB, free: 30.95 MB / 318.1 MB
Notification: Performance of Templates: time 0.02217/0.3451, allocations: 14.65 MB / 419.3 MB, free: 21.79 MB / 318.1 MB
"
[Timeout remaining time 660]
make -j1 -f Modelica_3.2.3_Modelica.Thermal.FluidHeatFlow.Examples.TwoMass.makefile [Timeout 660]
(rm -f Modelica_3.2.3_Modelica.Thermal.FluidHeatFlow.Examples.TwoMass.pipe ; mkfifo Modelica_3.2.3_Modelica.Thermal.FluidHeatFlow.Examples.TwoMass.pipe ; head -c 1048576 < Modelica_3.2.3_Modelica.Thermal.FluidHeatFlow.Examples.TwoMass.pipe >> ../files/Modelica_3.2.3_Modelica.Thermal.FluidHeatFlow.Examples.TwoMass.sim & ./Modelica_3.2.3_Modelica.Thermal.FluidHeatFlow.Examples.TwoMass  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Modelica_3.2.3_Modelica.Thermal.FluidHeatFlow.Examples.TwoMass.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 5.549027514003683]
Failed to read output from testmodel.py, exit status != 0:
['time', 'heatCapacitor1.T', 'heatCapacitor2.T', 'pipe1.T', 'pipe2.T', 'pipe3.T']
0.35630692198174074 0.362925482 0.33119020000000005
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fab58786fb0>