Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Sensors.TestSpecificEntropy.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001276/0.001276, allocations: 117.9 kB / 18.5 MB, free: 4.52 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001386/0.001386, allocations: 214.5 kB / 21.46 MB, free: 1.566 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.501/1.501, allocations: 230.5 MB / 254.7 MB, free: 15.03 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo): time 0.2342/0.2342, allocations: 46.92 MB / 357.7 MB, free: 10.21 MB / 286.1 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: "" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Sensors.TestSpecificEntropy,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_Fluid_TestComponents_Sensors_TestSpecificEntropy",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Sensors.TestSpecificEntropy,fileNamePrefix="ModelicaTest_4_1_0-beta_om_ModelicaTest_Fluid_TestComponents_Sensors_TestSpecificEntropy",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Warning: Requested package Modelica of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions.
Notification: Performance of FrontEnd - loaded program: time 0.002309/0.002309, allocations: 79.86 kB / 0.4917 GB, free: 7.746 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1458/0.1481, allocations: 66.04 MB / 0.5562 GB, free: 5.578 MB / 414.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Sensors.TestSpecificEntropy): time 0.03658/0.1847, allocations: 30.41 MB / 0.5858 GB, free: 7.055 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.3507/0.5354, allocations: 17.68 MB / 0.6031 GB, free: 3.727 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005542/0.5359, allocations: 15.47 kB / 0.6031 GB, free: 3.727 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0009381/0.5369, allocations: 218.4 kB / 0.6033 GB, free: 3.723 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0009725/0.5379, allocations: 279.4 kB / 0.6036 GB, free: 3.711 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.02044/0.5583, allocations: 6.063 MB / 0.6095 GB, free: 3.406 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.001442/0.5597, allocations: 0.8414 MB / 0.6103 GB, free: 3.242 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003842/0.5601, allocations: 208.2 kB / 0.6105 GB, free: 3.223 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.01108/0.5712, allocations: 5.481 MB / 0.6159 GB, free: 1.613 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0007287/0.5719, allocations: 261.9 kB / 0.6161 GB, free: 1.559 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 9.016e-05/0.572, allocations: 30 kB / 0.6162 GB, free: 1.559 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01495/0.587, allocations: 6.336 MB / 0.6224 GB, free: 0.8125 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0002263/0.5872, allocations: 94.95 kB / 0.6225 GB, free: 0.7617 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004187/0.5876, allocations: 194.9 kB / 0.6226 GB, free: 0.6445 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01249/0.6001, allocations: 3.87 MB / 0.6264 GB, free: 14.34 MB / 462.1 MB
Notification: Performance of FrontEnd - DAE generated: time 8.195e-06/0.6001, allocations: 0 / 0.6264 GB, free: 14.34 MB / 462.1 MB
Notification: Performance of FrontEnd: time 2.265e-06/0.6001, allocations: 0 / 0.6264 GB, free: 14.34 MB / 462.1 MB
Notification: Performance of Transformations before backend: time 1.536e-05/0.6001, allocations: 1.781 kB / 0.6264 GB, free: 14.34 MB / 462.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 64
 * Number of variables: 64
Notification: Performance of Generate backend data structure: time 0.003569/0.6037, allocations: 1.068 MB / 0.6275 GB, free: 13.52 MB / 462.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.826e-05/0.6037, allocations: 10.59 kB / 0.6275 GB, free: 13.52 MB / 462.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 8.341e-05/0.6038, allocations: 63.12 kB / 0.6275 GB, free: 13.45 MB / 462.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001707/0.6055, allocations: 204.8 kB / 0.6277 GB, free: 13.38 MB / 462.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0006235/0.6062, allocations: 357.7 kB / 0.6281 GB, free: 13.05 MB / 462.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.531e-05/0.6062, allocations: 24.72 kB / 0.6281 GB, free: 13.04 MB / 462.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 4.385e-05/0.6062, allocations: 24.84 kB / 0.6281 GB, free: 13.03 MB / 462.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001301/0.6075, allocations: 494.2 kB / 0.6286 GB, free: 12.69 MB / 462.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.266e-05/0.6075, allocations: 3.938 kB / 0.6286 GB, free: 12.68 MB / 462.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 3.638e-05/0.6076, allocations: 12.53 kB / 0.6286 GB, free: 12.68 MB / 462.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.776e-06/0.6076, allocations: 7.469 kB / 0.6286 GB, free: 12.68 MB / 462.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001249/0.6088, allocations: 407.8 kB / 0.629 GB, free: 12.49 MB / 462.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.003286/0.6121, allocations: 2.434 MB / 0.6314 GB, free: 10.21 MB / 462.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001207/0.6133, allocations: 313.8 kB / 0.6317 GB, free: 10.05 MB / 462.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003228/0.6137, allocations: 103.1 kB / 0.6318 GB, free: 9.996 MB / 462.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.03708/0.6507, allocations: 18.38 MB / 0.6497 GB, free: 9.07 MB / 478.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.562e-05/0.6508, allocations: 34.56 kB / 0.6498 GB, free: 9.027 MB / 478.1 MB
Notification: Performance of pre-optimization done (n=15): time 2.124e-06/0.6508, allocations: 4 kB / 0.6498 GB, free: 9.023 MB / 478.1 MB
Notification: Performance of matching and sorting (n=15): time 0.00225/0.653, allocations: 0.5204 MB / 0.6503 GB, free: 8.496 MB / 478.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.624e-05/0.6531, allocations: 102.8 kB / 0.6504 GB, free: 8.371 MB / 478.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0004523/0.6536, allocations: 328.4 kB / 0.6507 GB, free: 8.047 MB / 478.1 MB
Notification: Performance of collectPreVariables (initialization): time 3.937e-05/0.6536, allocations: 37.64 kB / 0.6507 GB, free: 8.004 MB / 478.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0001758/0.6538, allocations: 208 kB / 0.6509 GB, free: 7.797 MB / 478.1 MB
Notification: Performance of collectInitialBindings (initialization): time 5.589e-05/0.6538, allocations: 54 kB / 0.651 GB, free: 7.746 MB / 478.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001134/0.654, allocations: 69.64 kB / 0.651 GB, free: 7.672 MB / 478.1 MB
Notification: Performance of setup shared object (initialization): time 0.000164/0.6541, allocations: 338.8 kB / 0.6514 GB, free: 7.332 MB / 478.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002976/0.6544, allocations: 99.86 kB / 0.6515 GB, free: 7.234 MB / 478.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004038/0.6548, allocations: 219.2 kB / 0.6517 GB, free: 6.965 MB / 478.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0006647/0.6555, allocations: 295.5 kB / 0.6519 GB, free: 6.629 MB / 478.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.517e-06/0.6555, allocations: 0 / 0.6519 GB, free: 6.629 MB / 478.1 MB
Notification: Performance of matching and sorting (n=30) (initialization): time 0.0008723/0.6564, allocations: 346.3 kB / 0.6523 GB, free: 6.285 MB / 478.1 MB
Notification: Performance of prepare postOptimizeDAE: time 1.819e-05/0.6564, allocations: 4.469 kB / 0.6523 GB, free: 6.281 MB / 478.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.053e-05/0.6564, allocations: 8 kB / 0.6523 GB, free: 6.273 MB / 478.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.129e-05/0.6564, allocations: 7.938 kB / 0.6523 GB, free: 6.266 MB / 478.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0002971/0.6567, allocations: 71.89 kB / 0.6524 GB, free: 6.195 MB / 478.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.305e-05/0.6567, allocations: 5.641 kB / 0.6524 GB, free: 6.191 MB / 478.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0002934/0.657, allocations: 51.7 kB / 0.6524 GB, free: 6.141 MB / 478.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 2.852e-05/0.657, allocations: 12 kB / 0.6524 GB, free: 6.129 MB / 478.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 16
 * Number of states: 0 ()
 * Number of discrete variables: 2 (boundary_prescriberho_2.medium.phase,boundary_prescriberho_1.medium.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (30):
 * Single equations (assignments): 30
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0002021/0.6572, allocations: 157.8 kB / 0.6526 GB, free: 5.965 MB / 478.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 8.533e-05/0.6573, allocations: 31.81 kB / 0.6526 GB, free: 5.934 MB / 478.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001573/0.6589, allocations: 1.107 MB / 0.6537 GB, free: 4.828 MB / 478.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.105e-05/0.6589, allocations: 19.97 kB / 0.6537 GB, free: 4.809 MB / 478.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.63e-06/0.6589, allocations: 0 / 0.6537 GB, free: 4.809 MB / 478.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.767e-06/0.6589, allocations: 0 / 0.6537 GB, free: 4.809 MB / 478.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0007821/0.6597, allocations: 0.6681 MB / 0.6544 GB, free: 4.094 MB / 478.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.338e-06/0.6597, allocations: 0 / 0.6544 GB, free: 4.094 MB / 478.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002282/0.6599, allocations: 51.88 kB / 0.6544 GB, free: 4.047 MB / 478.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 5.521e-06/0.66, allocations: 4 kB / 0.6544 GB, free: 4.043 MB / 478.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 1.685e-05/0.66, allocations: 7.938 kB / 0.6544 GB, free: 4.035 MB / 478.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.304e-06/0.66, allocations: 4 kB / 0.6544 GB, free: 4.031 MB / 478.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.262e-06/0.66, allocations: 0 / 0.6544 GB, free: 4.031 MB / 478.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0009684/0.6609, allocations: 0.6234 MB / 0.655 GB, free: 3.387 MB / 478.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001354/0.6611, allocations: 132.6 kB / 0.6552 GB, free: 3.238 MB / 478.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 7.36e-05/0.6611, allocations: 31.72 kB / 0.6552 GB, free: 3.207 MB / 478.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002243/0.6614, allocations: 23.97 kB / 0.6552 GB, free: 3.184 MB / 478.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.557e-05/0.6614, allocations: 15.98 kB / 0.6552 GB, free: 3.168 MB / 478.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 1.795e-05/0.6615, allocations: 11.92 kB / 0.6552 GB, free: 3.156 MB / 478.1 MB
Notification: Performance of sorting global known variables: time 0.000459/0.6619, allocations: 342.9 kB / 0.6556 GB, free: 2.824 MB / 478.1 MB
Notification: Performance of sort global known variables: time 9e-08/0.6619, allocations: 0 / 0.6556 GB, free: 2.824 MB / 478.1 MB
Notification: Performance of remove unused functions: time 0.003086/0.665, allocations: 0.8578 MB / 0.6564 GB, free: 1.965 MB / 478.1 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 0 ()
 * Number of discrete variables: 10 ($cse1.phase,$cse1.region,$cse2.phase,$cse2.region,$cse5.phase,$cse5.region,$cse6.phase,$cse6.region,boundary_prescriberho_1.medium.phase,boundary_prescriberho_2.medium.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (19):
 * Single equations (assignments): 15
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 4
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.006471/0.6715, allocations: 2.069 MB / 0.6584 GB, free: 15.96 MB / 494.1 MB
Notification: Performance of simCode: created initialization part: time 0.0008844/0.6724, allocations: 351.2 kB / 0.6588 GB, free: 15.62 MB / 494.1 MB
Notification: Performance of simCode: created event and clocks part: time 3.246e-06/0.6724, allocations: 0 / 0.6588 GB, free: 15.62 MB / 494.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.0003827/0.6728, allocations: 202.9 kB / 0.659 GB, free: 15.42 MB / 494.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001066/0.6738, allocations: 194 kB / 0.6591 GB, free: 15.24 MB / 494.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008332/0.6822, allocations: 4.285 MB / 0.6633 GB, free: 10.8 MB / 494.1 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005214/0.6827, allocations: 0.8757 MB / 0.6642 GB, free: 9.895 MB / 494.1 MB
Notification: Performance of simCode: alias equations: time 0.0004114/0.6831, allocations: 187 kB / 0.6644 GB, free: 9.711 MB / 494.1 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002751/0.6834, allocations: 191.4 kB / 0.6645 GB, free: 9.523 MB / 494.1 MB
Notification: Performance of SimCode: time 7.81e-07/0.6834, allocations: 4 kB / 0.6645 GB, free: 9.52 MB / 494.1 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.07848/0.7618, allocations: 40.5 MB / 0.7041 GB, free: 1.156 MB / 0.5137 GB
Notification: Performance of buildModelFMU: Generate platform static: time 10.43/11.19, allocations: 15.88 kB / 0.7041 GB, free: 1.141 MB / 0.5137 GB
"
[Timeout remaining time 649]
(rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Sensors.TestSpecificEntropy.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Sensors.TestSpecificEntropy.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Sensors.TestSpecificEntropy.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Sensors.TestSpecificEntropy.sim & python3 -m fmpy simulate  --output-file ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Sensors.TestSpecificEntropy_res.csv --start-time 0 --stop-time 1.01 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.000201597 ModelicaTest_4_1_0-beta_om_ModelicaTest_Fluid_TestComponents_Sensors_TestSpecificEntropy.fmu > ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Sensors.TestSpecificEntropy.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 14.529801824130118]
Failed to read output from testmodel.py, exit status != 0:
['time', 'specificEntropy.s', 'specificEntropy1.s']
11.301171496044844 11.327419721 10.722004933000001
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fc4e6a0d7e0>