Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo", uses=false)
Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo)
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(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|volDyn.ports.1..m_flow|gain.y|volDyn.Xi.1.|volSte.Xi.1.",fileNamePrefix="Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow")
translateModel(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|volDyn.ports.1..m_flow|gain.y|volDyn.Xi.1.|volSte.Xi.1.",fileNamePrefix="Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001666/0.001666, allocations: 108.2 kB / 16.41 MB, free: 6.488 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001722/0.001722, allocations: 183 kB / 17.34 MB, free: 5.766 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.408/1.408, allocations: 222.9 MB / 241 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.654/2.654, allocations: 461.9 MB / 0.7354 GB, free: 11.12 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001497/0.001497, allocations: 67.91 kB / 1.055 GB, free: 7.703 MB / 0.8262 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.8586/0.8601, allocations: 157.4 MB / 1.208 GB, free: 13.65 MB / 0.9356 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow): time 0.2322/1.092, allocations: 221.1 MB / 1.424 GB, free: 15.73 MB / 1.154 GB
Notification: Performance of NFInst.instExpressions: time 0.009095/1.101, allocations: 5.715 MB / 1.43 GB, free: 10 MB / 1.154 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001223/1.103, allocations: 47.69 kB / 1.43 GB, free: 9.957 MB / 1.154 GB
Notification: Performance of NFTyping.typeComponents: time 0.001443/1.104, allocations: 0.5786 MB / 1.431 GB, free: 9.375 MB / 1.154 GB
Notification: Performance of NFTyping.typeBindings: time 0.004571/1.109, allocations: 1.843 MB / 1.432 GB, free: 7.523 MB / 1.154 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003725/1.113, allocations: 1.194 MB / 1.434 GB, free: 6.336 MB / 1.154 GB
Notification: Performance of NFFlatten.flatten: time 0.003925/1.116, allocations: 2.949 MB / 1.436 GB, free: 3.379 MB / 1.154 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001419/1.118, allocations: 1.031 MB / 1.437 GB, free: 2.328 MB / 1.154 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001887/1.12, allocations: 1.078 MB / 1.438 GB, free: 1.246 MB / 1.154 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002013/1.122, allocations: 0.9408 MB / 1.439 GB, free: 324 kB / 1.154 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001899/1.122, allocations: 111.9 kB / 1.439 GB, free: 212 kB / 1.154 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002856/1.125, allocations: 1.434 MB / 1.441 GB, free: 14.77 MB / 1.17 GB
Notification: Performance of NFScalarize.scalarize: time 0.0004879/1.125, allocations: 458.8 kB / 1.441 GB, free: 14.32 MB / 1.17 GB
Notification: Performance of NFVerifyModel.verify: time 0.0007478/1.126, allocations: 0.6495 MB / 1.442 GB, free: 13.67 MB / 1.17 GB
Notification: Performance of NFConvertDAE.convert: time 0.003049/1.129, allocations: 2.131 MB / 1.444 GB, free: 11.53 MB / 1.17 GB
Notification: Performance of FrontEnd - DAE generated: time 4.869e-06/1.129, allocations: 0 / 1.444 GB, free: 11.53 MB / 1.17 GB
Notification: Performance of FrontEnd: time 1.673e-06/1.129, allocations: 0 / 1.444 GB, free: 11.53 MB / 1.17 GB
Notification: Performance of Transformations before backend: time 2.64e-05/1.129, allocations: 0 / 1.444 GB, free: 11.53 MB / 1.17 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 215
 * Number of variables: 215
Notification: Performance of Generate backend data structure: time 0.002611/1.132, allocations: 1.513 MB / 1.446 GB, free: 9.969 MB / 1.17 GB
Notification: Performance of prepare preOptimizeDAE: time 4.11e-05/1.132, allocations: 12.03 kB / 1.446 GB, free: 9.957 MB / 1.17 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002181/1.134, allocations: 318.3 kB / 1.446 GB, free: 9.645 MB / 1.17 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001393/1.136, allocations: 0.8552 MB / 1.447 GB, free: 8.746 MB / 1.17 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.206e-05/1.136, allocations: 62 kB / 1.447 GB, free: 8.684 MB / 1.17 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001292/1.136, allocations: 91.98 kB / 1.447 GB, free: 8.594 MB / 1.17 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00163/1.137, allocations: 0.9053 MB / 1.448 GB, free: 7.684 MB / 1.17 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.378e-05/1.137, allocations: 3.984 kB / 1.448 GB, free: 7.68 MB / 1.17 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.791e-05/1.137, allocations: 36 kB / 1.448 GB, free: 7.645 MB / 1.17 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.092e-05/1.138, allocations: 41.92 kB / 1.448 GB, free: 7.605 MB / 1.17 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001401/1.139, allocations: 0.8315 MB / 1.449 GB, free: 6.77 MB / 1.17 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.005376/1.144, allocations: 3.516 MB / 1.452 GB, free: 3.031 MB / 1.17 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0007793/1.145, allocations: 488.4 kB / 1.452 GB, free: 2.547 MB / 1.17 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004813/1.146, allocations: 307.2 kB / 1.453 GB, free: 2.246 MB / 1.17 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001867/1.146, allocations: 101.5 kB / 1.453 GB, free: 2.129 MB / 1.17 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.797e-05/1.146, allocations: 46.94 kB / 1.453 GB, free: 2.074 MB / 1.17 GB
Notification: Performance of pre-optimization done (n=47): time 2.224e-06/1.146, allocations: 0 / 1.453 GB, free: 2.074 MB / 1.17 GB
Notification: Performance of matching and sorting (n=49): time 0.003701/1.15, allocations: 1.876 MB / 1.455 GB, free: 104 kB / 1.17 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.102e-05/1.15, allocations: 55.84 kB / 1.455 GB, free: 36 kB / 1.17 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001021/1.151, allocations: 0.8174 MB / 1.456 GB, free: 15.21 MB / 1.186 GB
Notification: Performance of collectPreVariables (initialization): time 5.873e-05/1.151, allocations: 37.7 kB / 1.456 GB, free: 15.17 MB / 1.186 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003753/1.151, allocations: 479.2 kB / 1.456 GB, free: 14.69 MB / 1.186 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001649/1.151, allocations: 173.6 kB / 1.456 GB, free: 14.52 MB / 1.186 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001901/1.151, allocations: 118.2 kB / 1.456 GB, free: 14.4 MB / 1.186 GB
Notification: Performance of setup shared object (initialization): time 0.0001329/1.152, allocations: 330 kB / 1.457 GB, free: 14.07 MB / 1.186 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00045/1.152, allocations: 245.2 kB / 1.457 GB, free: 13.83 MB / 1.186 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005295/1.153, allocations: 380.7 kB / 1.457 GB, free: 13.41 MB / 1.186 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: volDyn.dynBal.medium.p = volDyn.dynBal.p_start (bou.p = volDyn.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.003713/1.156, allocations: 1.541 MB / 1.459 GB, free: 11.81 MB / 1.186 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.697e-06/1.156, allocations: 0 / 1.459 GB, free: 11.81 MB / 1.186 GB
Notification: Performance of matching and sorting (n=74) (initialization): time 0.001393/1.158, allocations: 0.7961 MB / 1.46 GB, free: 11 MB / 1.186 GB
Notification: Performance of prepare postOptimizeDAE: time 2.237e-05/1.158, allocations: 8.406 kB / 1.46 GB, free: 10.99 MB / 1.186 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.446e-06/1.158, allocations: 7.938 kB / 1.46 GB, free: 10.98 MB / 1.186 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001844/1.158, allocations: 73.61 kB / 1.46 GB, free: 10.9 MB / 1.186 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000675/1.159, allocations: 143.8 kB / 1.46 GB, free: 10.76 MB / 1.186 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002687/1.161, allocations: 3.125 MB / 1.463 GB, free: 7.352 MB / 1.186 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008978/1.162, allocations: 27.92 kB / 1.463 GB, free: 7.324 MB / 1.186 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.433e-05/1.162, allocations: 24 kB / 1.463 GB, free: 7.301 MB / 1.186 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization system:
         volDyn.dynBal.medium.p = volDyn.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 14
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (71):
 * Single equations (assignments): 69
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,1), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.0005452/1.163, allocations: 309.6 kB / 1.463 GB, free: 6.988 MB / 1.186 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001642/1.163, allocations: 94.88 kB / 1.463 GB, free: 6.895 MB / 1.186 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0001877/1.163, allocations: 100.7 kB / 1.463 GB, free: 6.797 MB / 1.186 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.581e-06/1.163, allocations: 4 kB / 1.463 GB, free: 6.793 MB / 1.186 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.765e-06/1.163, allocations: 0 / 1.463 GB, free: 6.793 MB / 1.186 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001104/1.164, allocations: 0.8349 MB / 1.464 GB, free: 5.867 MB / 1.186 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002826/1.167, allocations: 1.791 MB / 1.466 GB, free: 3.977 MB / 1.186 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.663e-06/1.167, allocations: 4 kB / 1.466 GB, free: 3.973 MB / 1.186 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006271/1.168, allocations: 128.2 kB / 1.466 GB, free: 3.848 MB / 1.186 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0001096/1.168, allocations: 40.78 kB / 1.466 GB, free: 3.805 MB / 1.186 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.783e-05/1.168, allocations: 19.98 kB / 1.466 GB, free: 3.785 MB / 1.186 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001315/1.169, allocations: 1.595 MB / 1.468 GB, free: 2.055 MB / 1.186 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.298e-06/1.169, allocations: 4 kB / 1.468 GB, free: 2.051 MB / 1.186 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001597/1.171, allocations: 1.07 MB / 1.469 GB, free: 0.9258 MB / 1.186 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003999/1.171, allocations: 236 kB / 1.469 GB, free: 0.6758 MB / 1.186 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001154/1.172, allocations: 15.94 kB / 1.469 GB, free: 0.6602 MB / 1.186 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007182/1.172, allocations: 29.95 kB / 1.469 GB, free: 0.6328 MB / 1.186 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001079/1.172, allocations: 47.95 kB / 1.469 GB, free: 0.5859 MB / 1.186 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.36e-05/1.172, allocations: 27.98 kB / 1.469 GB, free: 0.5586 MB / 1.186 GB
Notification: Performance of sorting global known variables: time 0.0007239/1.173, allocations: 0.5615 MB / 1.47 GB, free: 0 / 1.186 GB
Notification: Performance of sort global known variables: time 1.41e-07/1.173, allocations: 0 / 1.47 GB, free: 0 / 1.186 GB
Notification: Performance of remove unused functions: time 0.0008967/1.174, allocations: 280 kB / 1.47 GB, free: 15.72 MB / 1.201 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 14
 * Number of states: 2 (volDyn.dynBal.medium.Xi[1],volDyn.dynBal.U)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (47):
 * Single equations (assignments): 46
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0004494/1.175, allocations: 195.8 kB / 1.47 GB, free: 15.53 MB / 1.201 GB
Notification: Performance of simCode: created initialization part: time 0.00134/1.176, allocations: 0.7964 MB / 1.471 GB, free: 14.71 MB / 1.201 GB
Notification: Performance of simCode: created event and clocks part: time 7.253e-06/1.176, allocations: 4 kB / 1.471 GB, free: 14.7 MB / 1.201 GB
Notification: Performance of simCode: created simulation system equations: time 0.0006002/1.177, allocations: 415.7 kB / 1.471 GB, free: 14.29 MB / 1.201 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002629/1.179, allocations: 0.6029 MB / 1.472 GB, free: 13.7 MB / 1.201 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003031/1.182, allocations: 1.852 MB / 1.474 GB, free: 11.77 MB / 1.201 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007035/1.183, allocations: 1.088 MB / 1.475 GB, free: 10.65 MB / 1.201 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002269/1.183, allocations: 71.44 kB / 1.475 GB, free: 10.58 MB / 1.201 GB
Notification: Performance of SimCode: time 5.81e-07/1.183, allocations: 0 / 1.475 GB, free: 10.58 MB / 1.201 GB
Notification: Performance of Templates: time 0.02931/1.213, allocations: 22.03 MB / 1.496 GB, free: 4.68 MB / 1.217 GB
make -j1 -f Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow.makefile
(rm -f Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow.pipe ; mkfifo Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow.pipe >> ../files/Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow.sim & ./Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_MixingVolumes_Validation_MixingVolumeMoistureReverseFlow.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
""

Variables in the reference:time,volDyn.ports[1].m_flow,gain.y,volDyn.Xi[1],volSte.Xi[1]

Variables in the result:gain.y,time,volDyn.Xi[1],volDyn.ports[1].m_flow,volSte.Xi[1]