Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationSteadyState.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/BuildSysPro 3.6.0/package.mo", uses=false)
Using package BuildSysPro with version 3.5.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/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: "" <> buildModelFMU(BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationSteadyState,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_MixingVolumes_Validation_MoistureMixingConservationSteadyState",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationSteadyState,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_MixingVolumes_Validation_MoistureMixingConservationSteadyState",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001106/0.001106, allocations: 108 kB / 15.6 MB, free: 132 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001096/0.001096, allocations: 198.5 kB / 16.54 MB, free: 6.672 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.318/1.318, allocations: 222.9 MB / 240.2 MB, free: 4.395 MB / 190.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/Building/BuildingEnvelope/HeatTransfer/package.mo:2:1-40:17:writable] Warning: Soil_case_nappe was referenced in the package.order file, but was not found in package.mo, Soil_case_nappe/package.mo or Soil_case_nappe.mo.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/package.mo): time 0.9824/0.9824, allocations: 143 MB / 433.4 MB, free: 11.5 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001362/0.001362, allocations: 67.89 kB / 0.5143 GB, free: 11.59 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1448/0.1462, allocations: 82.03 MB / 0.5944 GB, free: 9.52 MB / 0.4981 GB
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationSteadyState): time 0.4748/0.6211, allocations: 222.1 MB / 0.8112 GB, free: 15.03 MB / 0.6387 GB
Notification: Performance of NFInst.instExpressions: time 0.01866/0.6398, allocations: 13.78 MB / 0.8247 GB, free: 1.215 MB / 0.6387 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002096/0.6419, allocations: 67.62 kB / 0.8248 GB, free: 1.148 MB / 0.6387 GB
Notification: Performance of NFTyping.typeComponents: time 0.002163/0.6441, allocations: 0.8074 MB / 0.8255 GB, free: 344 kB / 0.6387 GB
Notification: Performance of NFTyping.typeBindings: time 0.005781/0.6499, allocations: 2.162 MB / 0.8277 GB, free: 14.16 MB / 0.6544 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003093/0.653, allocations: 1.171 MB / 0.8288 GB, free: 13.01 MB / 0.6544 GB
Notification: Performance of NFFlatten.flatten: time 0.003688/0.6567, allocations: 2.887 MB / 0.8316 GB, free: 10.12 MB / 0.6544 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001763/0.6585, allocations: 1.203 MB / 0.8328 GB, free: 8.898 MB / 0.6544 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006142/0.6647, allocations: 2.429 MB / 0.8352 GB, free: 6.469 MB / 0.6544 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002834/0.6675, allocations: 1.035 MB / 0.8362 GB, free: 5.461 MB / 0.6544 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004033/0.6679, allocations: 103.9 kB / 0.8363 GB, free: 5.359 MB / 0.6544 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003287/0.6712, allocations: 1.582 MB / 0.8378 GB, free: 3.773 MB / 0.6544 GB
Notification: Performance of NFScalarize.scalarize: time 0.000586/0.6718, allocations: 430.7 kB / 0.8382 GB, free: 3.352 MB / 0.6544 GB
Notification: Performance of NFVerifyModel.verify: time 0.001106/0.6729, allocations: 0.6763 MB / 0.8389 GB, free: 2.672 MB / 0.6544 GB
Notification: Performance of NFConvertDAE.convert: time 0.003314/0.6763, allocations: 2.111 MB / 0.841 GB, free: 0.5547 MB / 0.6544 GB
Notification: Performance of FrontEnd - DAE generated: time 4.158e-06/0.6763, allocations: 0 / 0.841 GB, free: 0.5547 MB / 0.6544 GB
Notification: Performance of FrontEnd: time 1.472e-06/0.6763, allocations: 4 kB / 0.841 GB, free: 0.5508 MB / 0.6544 GB
Notification: Performance of Transformations before backend: time 4.87e-05/0.6763, allocations: 0 / 0.841 GB, free: 0.5508 MB / 0.6544 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 225
 * Number of variables: 225
Notification: Performance of Generate backend data structure: time 0.002657/0.679, allocations: 1.657 MB / 0.8426 GB, free: 14.84 MB / 0.67 GB
Notification: Performance of prepare preOptimizeDAE: time 4.485e-05/0.6791, allocations: 12.03 kB / 0.8426 GB, free: 14.83 MB / 0.67 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001577/0.6792, allocations: 135.6 kB / 0.8427 GB, free: 14.69 MB / 0.67 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002173/0.6814, allocations: 441.8 kB / 0.8431 GB, free: 14.26 MB / 0.67 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001249/0.6827, allocations: 0.8935 MB / 0.844 GB, free: 13.32 MB / 0.67 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000974/0.6837, allocations: 233.8 kB / 0.8442 GB, free: 13.09 MB / 0.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001162/0.6838, allocations: 92 kB / 0.8443 GB, free: 13 MB / 0.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002013/0.6858, allocations: 1.235 MB / 0.8455 GB, free: 11.65 MB / 0.67 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.048e-05/0.6858, allocations: 0 / 0.8455 GB, free: 11.65 MB / 0.67 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.319e-05/0.6859, allocations: 40 kB / 0.8456 GB, free: 11.61 MB / 0.67 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.629e-05/0.686, allocations: 41.23 kB / 0.8456 GB, free: 11.57 MB / 0.67 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002036/0.688, allocations: 0.8985 MB / 0.8465 GB, free: 10.67 MB / 0.67 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.006588/0.6946, allocations: 6.077 MB / 0.8524 GB, free: 4.309 MB / 0.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0004025/0.695, allocations: 259.7 kB / 0.8527 GB, free: 4 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0001997/0.6952, allocations: 153.1 kB / 0.8528 GB, free: 3.832 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001663/0.6954, allocations: 93.11 kB / 0.8529 GB, free: 3.723 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.221e-05/0.6955, allocations: 46.48 kB / 0.8529 GB, free: 3.668 MB / 0.67 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0006681/0.6961, allocations: 115.7 kB / 0.8531 GB, free: 3.555 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=20): time 3.016e-06/0.6961, allocations: 0 / 0.8531 GB, free: 3.555 MB / 0.67 GB
Notification: Performance of matching and sorting (n=20): time 0.001314/0.6975, allocations: 485.4 kB / 0.8535 GB, free: 3.074 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001095/0.6976, allocations: 187.9 kB / 0.8537 GB, free: 2.848 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002121/0.6997, allocations: 1.319 MB / 0.855 GB, free: 1.512 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 3.872e-05/0.6998, allocations: 33.7 kB / 0.855 GB, free: 1.473 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005238/0.7003, allocations: 0.6165 MB / 0.8556 GB, free: 0.8477 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 6.909e-05/0.7004, allocations: 78.94 kB / 0.8557 GB, free: 0.7695 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002218/0.7006, allocations: 137.9 kB / 0.8558 GB, free: 0.6289 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 0.0001126/0.7007, allocations: 334 kB / 0.8561 GB, free: 304 kB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0007521/0.7015, allocations: 252.9 kB / 0.8564 GB, free: 52 kB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.2451/0.9466, allocations: 0.5641 MB / 0.8569 GB, free: 213.8 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001239/0.9479, allocations: 0.7071 MB / 0.8576 GB, free: 213.4 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.4e-05/0.9479, allocations: 7.812 kB / 0.8576 GB, free: 213.4 MB / 0.67 GB
Notification: Performance of matching and sorting (n=69) (initialization): time 0.002309/0.9503, allocations: 0.8799 MB / 0.8585 GB, free: 213.4 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 2.615e-05/0.9503, allocations: 8.406 kB / 0.8585 GB, free: 213.4 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.807e-05/0.9503, allocations: 11.44 kB / 0.8585 GB, free: 213.4 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.888e-05/0.9504, allocations: 11.72 kB / 0.8585 GB, free: 213.4 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007861/0.9512, allocations: 178.6 kB / 0.8587 GB, free: 213.4 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.362e-05/0.9512, allocations: 22.75 kB / 0.8587 GB, free: 213.4 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001813/0.953, allocations: 154 kB / 0.8589 GB, free: 213.4 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001135/0.9531, allocations: 37.81 kB / 0.8589 GB, free: 213.4 MB / 0.67 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 46
 * 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 (69):
 * 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: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0006734/0.9538, allocations: 296.5 kB / 0.8592 GB, free: 213.3 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004285/0.9543, allocations: 117.5 kB / 0.8593 GB, free: 213.3 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0006303/0.9549, allocations: 290.7 kB / 0.8596 GB, free: 213.2 MB / 0.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.074e-06/0.9549, allocations: 2.812 kB / 0.8596 GB, free: 213.2 MB / 0.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.237e-05/0.9549, allocations: 10.42 kB / 0.8596 GB, free: 213.2 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.112e-06/0.9549, allocations: 3.25 kB / 0.8596 GB, free: 213.2 MB / 0.67 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002032/0.957, allocations: 1.672 MB / 0.8612 GB, free: 212.4 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.888e-06/0.957, allocations: 2.781 kB / 0.8612 GB, free: 212.4 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002105/0.9572, allocations: 43.27 kB / 0.8613 GB, free: 212.4 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (simulation): time 5.35e-06/0.9572, allocations: 6.875 kB / 0.8613 GB, free: 212.4 MB / 0.67 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 1.712e-05/0.9573, allocations: 10.28 kB / 0.8613 GB, free: 212.4 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 4.628e-06/0.9573, allocations: 6.656 kB / 0.8613 GB, free: 212.4 MB / 0.67 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.075e-06/0.9573, allocations: 2.812 kB / 0.8613 GB, free: 212.4 MB / 0.67 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0004262/0.9577, allocations: 0.4953 MB / 0.8618 GB, free: 212.2 MB / 0.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002618/0.958, allocations: 237.8 kB / 0.862 GB, free: 212 MB / 0.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001486/0.9581, allocations: 5.719 kB / 0.862 GB, free: 212 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000757/0.9589, allocations: 56.27 kB / 0.8621 GB, free: 212 MB / 0.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 4.434e-05/0.9589, allocations: 27.36 kB / 0.8621 GB, free: 212 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 1.949e-05/0.959, allocations: 11.44 kB / 0.8621 GB, free: 212 MB / 0.67 GB
Notification: Performance of sorting global known variables: time 0.001377/0.9604, allocations: 0.9289 MB / 0.863 GB, free: 211.9 MB / 0.67 GB
Notification: Performance of sort global known variables: time 1.6e-07/0.9604, allocations: 2.281 kB / 0.863 GB, free: 211.9 MB / 0.67 GB
Notification: Performance of remove unused functions: time 0.000831/0.9612, allocations: 276.4 kB / 0.8633 GB, free: 211.9 MB / 0.67 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 13
 * 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 simulation (20):
 * Single equations (assignments): 20
 * 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 Backend phase and start with SimCode phase: time 0.0009393/0.9621, allocations: 1.141 MB / 0.8644 GB, free: 211.1 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.001058/0.9632, allocations: 478.1 kB / 0.8648 GB, free: 211.1 MB / 0.67 GB
Notification: Performance of simCode: created event and clocks part: time 3.316e-06/0.9632, allocations: 0 / 0.8648 GB, free: 211.1 MB / 0.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.0001303/0.9634, allocations: 105.6 kB / 0.8649 GB, free: 211.1 MB / 0.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002452/0.9658, allocations: 0.5861 MB / 0.8655 GB, free: 211.1 MB / 0.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01064/0.9765, allocations: 8.745 MB / 0.874 GB, free: 206.1 MB / 0.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004581/0.977, allocations: 1.119 MB / 0.8751 GB, free: 205.3 MB / 0.67 GB
Notification: Performance of simCode: alias equations: time 0.000939/0.9779, allocations: 238.7 kB / 0.8754 GB, free: 205.3 MB / 0.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004063/0.9783, allocations: 412.2 kB / 0.8758 GB, free: 205 MB / 0.67 GB
Notification: Performance of SimCode: time 6.41e-07/0.9783, allocations: 3.828 kB / 0.8758 GB, free: 205 MB / 0.67 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.0575/1.036, allocations: 27.43 MB / 0.9026 GB, free: 201.5 MB / 0.67 GB
Notification: Performance of buildModelFMU: Generate platform static: time 7.66/8.696, allocations: 9.578 kB / 0.9026 GB, free: 201.5 MB / 0.67 GB
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationSteadyState.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationSteadyState.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationSteadyState.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationSteadyState.sim & python3 -m fmpy simulate  --output-file BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationSteadyState_res.csv --start-time 0 --stop-time 1 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.0004 BuildSysPro_BuildSysPro_IBPSA_Fluid_MixingVolumes_Validation_MoistureMixingConservationSteadyState.fmu > BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationSteadyState.pipe 2>&1)