Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.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.Airflow.Multizone.Validation.ThreeRoomsContam,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Airflow_Multizone_Validation_ThreeRoomsContam",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(BuildSysPro.IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Airflow_Multizone_Validation_ThreeRoomsContam",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.001124/0.001124, 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.001106/0.001106, allocations: 194.7 kB / 16.53 MB, free: 6.391 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.168/1.168, allocations: 222.9 MB / 240.2 MB, free: 4.387 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.8311/0.8311, allocations: 143 MB / 433.4 MB, free: 11.41 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.00109/0.00109, allocations: 67.89 kB / 0.5143 GB, free: 11.57 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1188/0.1199, allocations: 82.02 MB / 0.5944 GB, free: 9.5 MB / 0.4981 GB
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam): time 0.6851/0.8051, allocations: 284.6 MB / 0.8723 GB, free: 1.578 MB / 0.67 GB
Notification: Performance of NFInst.instExpressions: time 0.01647/0.8216, allocations: 17.35 MB / 0.8892 GB, free: 1.516 MB / 0.67 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00196/0.8236, allocations: 71.41 kB / 0.8893 GB, free: 1.516 MB / 0.67 GB
Notification: Performance of NFTyping.typeComponents: time 0.002797/0.8264, allocations: 1.71 MB / 0.891 GB, free: 1.488 MB / 0.67 GB
Notification: Performance of NFTyping.typeBindings: time 0.01022/0.8367, allocations: 5.893 MB / 0.8967 GB, free: 1.262 MB / 0.67 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005607/0.8423, allocations: 2.793 MB / 0.8995 GB, free: 1.191 MB / 0.67 GB
Notification: Performance of NFFlatten.flatten: time 0.006328/0.8486, allocations: 6.579 MB / 0.9059 GB, free: 1.191 MB / 0.67 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002833/0.8515, allocations: 2.557 MB / 0.9084 GB, free: 16.93 MB / 0.6856 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003378/0.8548, allocations: 2.448 MB / 0.9108 GB, free: 16.93 MB / 0.6856 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002767/0.8576, allocations: 2.401 MB / 0.9131 GB, free: 16.93 MB / 0.6856 GB
Notification: Performance of NFPackage.collectConstants: time 0.000472/0.8581, allocations: 300.8 kB / 0.9134 GB, free: 16.93 MB / 0.6856 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.009245/0.8674, allocations: 5.939 MB / 0.9192 GB, free: 16.88 MB / 0.6856 GB
Notification: Performance of NFScalarize.scalarize: time 0.0009748/0.8683, allocations: 1.304 MB / 0.9205 GB, free: 16.87 MB / 0.6856 GB
Notification: Performance of NFVerifyModel.verify: time 0.001397/0.8697, allocations: 1.711 MB / 0.9222 GB, free: 16.5 MB / 0.6856 GB
Notification: Performance of NFConvertDAE.convert: time 0.006421/0.8762, allocations: 6.566 MB / 0.9286 GB, free: 15.82 MB / 0.6856 GB
Notification: Performance of FrontEnd - DAE generated: time 3.186e-06/0.8762, allocations: 2.969 kB / 0.9286 GB, free: 15.82 MB / 0.6856 GB
Notification: Performance of FrontEnd: time 1.142e-06/0.8762, allocations: 0 / 0.9286 GB, free: 15.82 MB / 0.6856 GB
Notification: Performance of Transformations before backend: time 2.978e-05/0.8762, allocations: 0 / 0.9286 GB, free: 15.82 MB / 0.6856 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 627
 * Number of variables: 627
Notification: Performance of Generate backend data structure: time 0.006892/0.8831, allocations: 3.758 MB / 0.9322 GB, free: 14.09 MB / 0.6856 GB
Notification: Performance of prepare preOptimizeDAE: time 2.95e-05/0.8832, allocations: 8.062 kB / 0.9322 GB, free: 14.09 MB / 0.6856 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0003372/0.8835, allocations: 353.7 kB / 0.9326 GB, free: 13.97 MB / 0.6856 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004507/0.888, allocations: 0.819 MB / 0.9334 GB, free: 13.64 MB / 0.6856 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002033/0.8901, allocations: 1.635 MB / 0.935 GB, free: 12.89 MB / 0.6856 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.06e-05/0.8902, allocations: 184.4 kB / 0.9352 GB, free: 12.89 MB / 0.6856 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002809/0.8904, allocations: 244.2 kB / 0.9354 GB, free: 12.89 MB / 0.6856 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003775/0.8942, allocations: 3.092 MB / 0.9384 GB, free: 12 MB / 0.6856 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.358e-05/0.8943, allocations: 14 kB / 0.9384 GB, free: 11.99 MB / 0.6856 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002012/0.8945, allocations: 103.8 kB / 0.9385 GB, free: 11.99 MB / 0.6856 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001001/0.8946, allocations: 137.8 kB / 0.9387 GB, free: 11.96 MB / 0.6856 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003758/0.8984, allocations: 2.843 MB / 0.9414 GB, free: 11.49 MB / 0.6856 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.0108/0.9092, allocations: 12.18 MB / 0.9533 GB, free: 2.957 MB / 0.6856 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002591/0.9118, allocations: 2.295 MB / 0.9556 GB, free: 2.297 MB / 0.6856 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001535/0.9133, allocations: 1.244 MB / 0.9568 GB, free: 1.516 MB / 0.6856 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001075/0.9144, allocations: 1.369 MB / 0.9581 GB, free: 15.87 MB / 0.7012 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.284e-05/0.9145, allocations: 56.62 kB / 0.9582 GB, free: 15.82 MB / 0.7012 GB
Notification: Performance of pre-optimization done (n=197): time 3.206e-06/0.9145, allocations: 0 / 0.9582 GB, free: 15.82 MB / 0.7012 GB
Notification: Performance of matching and sorting (n=197): time 0.004148/0.9186, allocations: 2.83 MB / 0.9609 GB, free: 13.89 MB / 0.7012 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.568e-05/0.9187, allocations: 73.41 kB / 0.961 GB, free: 13.81 MB / 0.7012 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001426/0.9201, allocations: 1.315 MB / 0.9623 GB, free: 12.57 MB / 0.7012 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001102/0.9202, allocations: 64.89 kB / 0.9624 GB, free: 12.5 MB / 0.7012 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005691/0.9208, allocations: 0.9555 MB / 0.9633 GB, free: 11.54 MB / 0.7012 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0004833/0.9213, allocations: 0.6733 MB / 0.9639 GB, free: 10.87 MB / 0.7012 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004133/0.9217, allocations: 299.5 kB / 0.9642 GB, free: 10.57 MB / 0.7012 GB
Notification: Performance of setup shared object (initialization): time 0.0001107/0.9218, allocations: 301.1 kB / 0.9645 GB, free: 10.27 MB / 0.7012 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001103/0.9229, allocations: 0.7847 MB / 0.9653 GB, free: 9.484 MB / 0.7012 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001239/0.9242, allocations: 0.9695 MB / 0.9662 GB, free: 8.484 MB / 0.7012 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002515/0.9267, allocations: 1.87 MB / 0.9681 GB, free: 6.59 MB / 0.7012 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.198e-06/0.9267, allocations: 0 / 0.9681 GB, free: 6.59 MB / 0.7012 GB
Notification: Performance of matching and sorting (n=219) (initialization): time 0.003015/0.9297, allocations: 2.165 MB / 0.9702 GB, free: 4.434 MB / 0.7012 GB
Notification: Performance of prepare postOptimizeDAE: time 1.576e-05/0.9298, allocations: 4 kB / 0.9702 GB, free: 4.43 MB / 0.7012 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.548e-06/0.9298, allocations: 4.344 kB / 0.9702 GB, free: 4.426 MB / 0.7012 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.857e-05/0.9298, allocations: 12 kB / 0.9702 GB, free: 4.414 MB / 0.7012 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00148/0.9313, allocations: 371 kB / 0.9705 GB, free: 4.07 MB / 0.7012 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.543e-05/0.9313, allocations: 11.09 kB / 0.9706 GB, free: 4.062 MB / 0.7012 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001433/0.9327, allocations: 149.9 kB / 0.9707 GB, free: 3.918 MB / 0.7012 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001105/0.9329, allocations: 60 kB / 0.9708 GB, free: 3.859 MB / 0.7012 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 12
 * 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 (219):
 * Single equations (assignments): 219
 * 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.0008755/0.9337, allocations: 0.5991 MB / 0.9713 GB, free: 3.27 MB / 0.7012 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002895/0.934, allocations: 200.7 kB / 0.9715 GB, free: 3.074 MB / 0.7012 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003313/0.9374, allocations: 2.25 MB / 0.9737 GB, free: 0.8086 MB / 0.7012 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.821e-05/0.9374, allocations: 20 kB / 0.9737 GB, free: 0.7891 MB / 0.7012 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.851e-06/0.9374, allocations: 0 / 0.9737 GB, free: 0.7891 MB / 0.7012 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002662/0.9401, allocations: 1.88 MB / 0.9756 GB, free: 14.91 MB / 0.7169 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00672/0.9468, allocations: 5.104 MB / 0.9806 GB, free: 9.75 MB / 0.7169 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.905e-06/0.9468, allocations: 7.984 kB / 0.9806 GB, free: 9.742 MB / 0.7169 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001736/0.9486, allocations: 422.8 kB / 0.981 GB, free: 9.348 MB / 0.7169 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.126e-05/0.9486, allocations: 8 kB / 0.981 GB, free: 9.34 MB / 0.7169 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.000107/0.9487, allocations: 51.98 kB / 0.981 GB, free: 9.289 MB / 0.7169 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.146e-05/0.9487, allocations: 8 kB / 0.981 GB, free: 9.281 MB / 0.7169 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.086e-06/0.9487, allocations: 7.375 kB / 0.9811 GB, free: 9.277 MB / 0.7169 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004403/0.9531, allocations: 3.406 MB / 0.9844 GB, free: 5.832 MB / 0.7169 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007541/0.9539, allocations: 0.5061 MB / 0.9849 GB, free: 5.305 MB / 0.7169 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002452/0.9541, allocations: 43.98 kB / 0.9849 GB, free: 5.262 MB / 0.7169 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00119/0.9553, allocations: 55.11 kB / 0.985 GB, free: 5.211 MB / 0.7169 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000228/0.9556, allocations: 129.7 kB / 0.9851 GB, free: 5.086 MB / 0.7169 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001101/0.9557, allocations: 63.98 kB / 0.9851 GB, free: 5.023 MB / 0.7169 GB
Notification: Performance of sorting global known variables: time 0.001017/0.9567, allocations: 0.9121 MB / 0.986 GB, free: 4.113 MB / 0.7169 GB
Notification: Performance of sort global known variables: time 1.3e-07/0.9567, allocations: 0 / 0.986 GB, free: 4.113 MB / 0.7169 GB
Notification: Performance of remove unused functions: time 0.001547/0.9583, allocations: 0.8455 MB / 0.9869 GB, free: 3.266 MB / 0.7169 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 11
 * Number of states: 16 (volEas.dynBal.medium.Xi[1],volEas.dynBal.U,volEas.dynBal.m,volEas.dynBal.mC[1],oriOutBot.mExc,oriOutTop.mExc,oriWesTop.mExc,volWes.dynBal.medium.Xi[1],volWes.dynBal.U,volWes.dynBal.m,volWes.dynBal.mC[1],oriEasTop.mExc,volTop.dynBal.medium.Xi[1],volTop.dynBal.U,volTop.dynBal.m,volTop.dynBal.mC[1])
 * 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 (201):
 * Single equations (assignments): 201
 * 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.005114/0.9634, allocations: 4.243 MB / 0.991 GB, free: 15.02 MB / 0.7325 GB
Notification: Performance of simCode: created initialization part: time 0.005662/0.9691, allocations: 3.152 MB / 0.9941 GB, free: 11.91 MB / 0.7325 GB
Notification: Performance of simCode: created event and clocks part: time 4.048e-06/0.9691, allocations: 4 kB / 0.9941 GB, free: 11.91 MB / 0.7325 GB
Notification: Performance of simCode: created simulation system equations: time 0.001312/0.9704, allocations: 1.083 MB / 0.9951 GB, free: 10.87 MB / 0.7325 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004562/0.975, allocations: 1.248 MB / 0.9964 GB, free: 9.68 MB / 0.7325 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0203/0.9953, allocations: 17.88 MB / 1.014 GB, free: 6.961 MB / 0.7481 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001214/0.9965, allocations: 1.828 MB / 1.016 GB, free: 5.094 MB / 0.7481 GB
Notification: Performance of simCode: alias equations: time 0.00203/0.9986, allocations: 0.6244 MB / 1.016 GB, free: 4.469 MB / 0.7481 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001152/0.9997, allocations: 0.964 MB / 1.017 GB, free: 3.504 MB / 0.7481 GB
Notification: Performance of SimCode: time 4.81e-07/0.9997, allocations: 0 / 1.017 GB, free: 3.504 MB / 0.7481 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.08404/1.084, allocations: 60.77 MB / 1.077 GB, free: 7.512 MB / 0.8106 GB
Notification: Performance of buildModelFMU: Generate platform static: time 7.815/8.899, allocations: 7.25 kB / 1.077 GB, free: 7.508 MB / 0.8106 GB
(rm -f BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.sim & python3 -m fmpy simulate  --output-file BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam_res.csv --start-time 0 --stop-time 3600 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 1.44 BuildSysPro_BuildSysPro_IBPSA_Airflow_Multizone_Validation_ThreeRoomsContam.fmu > BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Validation.ThreeRoomsContam.pipe 2>&1)