Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.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.Examples.PowerLaw,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Airflow_Multizone_Examples_PowerLaw",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Airflow_Multizone_Examples_PowerLaw",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.0009551/0.0009551, 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.0008826/0.0008826, allocations: 191.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.17/1.17, allocations: 222.9 MB / 240.2 MB, free: 4.414 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.8394/0.8394, allocations: 143 MB / 433.4 MB, free: 11.44 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001077/0.001077, allocations: 63.91 kB / 0.5143 GB, free: 11.58 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1203/0.1214, allocations: 82.04 MB / 0.5944 GB, free: 9.508 MB / 0.4981 GB
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw): time 0.3522/0.4736, allocations: 192.7 MB / 0.7826 GB, free: 12.43 MB / 0.6075 GB
Notification: Performance of NFInst.instExpressions: time 0.004923/0.4786, allocations: 4.028 MB / 0.7865 GB, free: 8.395 MB / 0.6075 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00029/0.4789, allocations: 19.94 kB / 0.7866 GB, free: 8.375 MB / 0.6075 GB
Notification: Performance of NFTyping.typeComponents: time 0.0009108/0.4798, allocations: 476.9 kB / 0.787 GB, free: 7.906 MB / 0.6075 GB
Notification: Performance of NFTyping.typeBindings: time 0.002386/0.4823, allocations: 1.524 MB / 0.7885 GB, free: 6.375 MB / 0.6075 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002314/0.4846, allocations: 1.352 MB / 0.7898 GB, free: 5.023 MB / 0.6075 GB
Notification: Performance of NFFlatten.flatten: time 0.001355/0.486, allocations: 1.628 MB / 0.7914 GB, free: 3.391 MB / 0.6075 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009089/0.4869, allocations: 0.9548 MB / 0.7924 GB, free: 2.426 MB / 0.6075 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0009235/0.4878, allocations: 0.915 MB / 0.7932 GB, free: 1.508 MB / 0.6075 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0008114/0.4886, allocations: 0.8527 MB / 0.7941 GB, free: 0.6523 MB / 0.6075 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001333/0.4888, allocations: 96 kB / 0.7942 GB, free: 0.5586 MB / 0.6075 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001707/0.4905, allocations: 1.309 MB / 0.7954 GB, free: 15.25 MB / 0.6231 GB
Notification: Performance of NFScalarize.scalarize: time 0.0002899/0.4908, allocations: 351 kB / 0.7958 GB, free: 14.9 MB / 0.6231 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004202/0.4912, allocations: 0.5055 MB / 0.7963 GB, free: 14.39 MB / 0.6231 GB
Notification: Performance of NFConvertDAE.convert: time 0.001511/0.4927, allocations: 1.663 MB / 0.7979 GB, free: 12.73 MB / 0.6231 GB
Notification: Performance of FrontEnd - DAE generated: time 3.166e-06/0.4927, allocations: 0 / 0.7979 GB, free: 12.73 MB / 0.6231 GB
Notification: Performance of FrontEnd: time 1.103e-06/0.4928, allocations: 4 kB / 0.7979 GB, free: 12.72 MB / 0.6231 GB
Notification: Performance of Transformations before backend: time 8.436e-06/0.4928, allocations: 4 kB / 0.7979 GB, free: 12.72 MB / 0.6231 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 127
 * Number of variables: 127
Notification: Performance of Generate backend data structure: time 0.00248/0.4952, allocations: 1.449 MB / 0.7993 GB, free: 11.22 MB / 0.6231 GB
Notification: Performance of prepare preOptimizeDAE: time 3.037e-05/0.4953, allocations: 12.03 kB / 0.7993 GB, free: 11.21 MB / 0.6231 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001098/0.4954, allocations: 95.2 kB / 0.7994 GB, free: 11.11 MB / 0.6231 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00136/0.4968, allocations: 242.6 kB / 0.7997 GB, free: 10.87 MB / 0.6231 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0006988/0.4975, allocations: 0.5953 MB / 0.8002 GB, free: 10.23 MB / 0.6231 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 2.602e-05/0.4975, allocations: 37 kB / 0.8003 GB, free: 10.2 MB / 0.6231 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001023/0.4976, allocations: 48 kB / 0.8003 GB, free: 10.15 MB / 0.6231 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001241/0.4989, allocations: 0.9648 MB / 0.8013 GB, free: 9.113 MB / 0.6231 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.615e-05/0.4989, allocations: 0 / 0.8013 GB, free: 9.113 MB / 0.6231 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.36e-05/0.499, allocations: 29.86 kB / 0.8013 GB, free: 9.086 MB / 0.6231 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.391e-05/0.499, allocations: 23.94 kB / 0.8013 GB, free: 9.062 MB / 0.6231 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001349/0.5004, allocations: 0.9407 MB / 0.8022 GB, free: 8.125 MB / 0.6231 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.004423/0.5048, allocations: 4.268 MB / 0.8064 GB, free: 3.684 MB / 0.6231 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0008405/0.5056, allocations: 0.59 MB / 0.807 GB, free: 3.082 MB / 0.6231 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006662/0.5063, allocations: 0.5175 MB / 0.8075 GB, free: 2.562 MB / 0.6231 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.00086/0.5072, allocations: 0.8705 MB / 0.8083 GB, free: 1.508 MB / 0.6231 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.463e-05/0.5072, allocations: 46.92 kB / 0.8084 GB, free: 1.453 MB / 0.6231 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001279/0.5085, allocations: 423.1 kB / 0.8088 GB, free: 1.039 MB / 0.6231 GB
Notification: Performance of pre-optimization done (n=50): time 1.654e-06/0.5085, allocations: 0 / 0.8088 GB, free: 1.039 MB / 0.6231 GB
Notification: Performance of matching and sorting (n=50): time 0.01623/0.5248, allocations: 3.833 MB / 0.8125 GB, free: 13.15 MB / 0.6387 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.956e-05/0.5248, allocations: 63.83 kB / 0.8126 GB, free: 13.07 MB / 0.6387 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0006957/0.5255, allocations: 0.7115 MB / 0.8133 GB, free: 12.36 MB / 0.6387 GB
Notification: Performance of collectPreVariables (initialization): time 6.57e-05/0.5256, allocations: 37.7 kB / 0.8133 GB, free: 12.31 MB / 0.6387 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001996/0.5258, allocations: 320.6 kB / 0.8136 GB, free: 12 MB / 0.6387 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001373/0.5259, allocations: 169.5 kB / 0.8138 GB, free: 11.83 MB / 0.6387 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002218/0.5261, allocations: 150 kB / 0.8139 GB, free: 11.68 MB / 0.6387 GB
Notification: Performance of setup shared object (initialization): time 9.656e-05/0.5262, allocations: 330 kB / 0.8142 GB, free: 11.35 MB / 0.6387 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005829/0.5268, allocations: 400.8 kB / 0.8146 GB, free: 10.96 MB / 0.6387 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0006441/0.5275, allocations: 485.5 kB / 0.8151 GB, free: 10.46 MB / 0.6387 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001318/0.5288, allocations: 0.918 MB / 0.816 GB, free: 9.512 MB / 0.6387 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.334e-06/0.5288, allocations: 0 / 0.816 GB, free: 9.512 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=60) (initialization): time 0.01058/0.5394, allocations: 2.56 MB / 0.8185 GB, free: 6.934 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 1.37e-05/0.5394, allocations: 8 kB / 0.8185 GB, free: 6.926 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.159e-06/0.5394, allocations: 0 / 0.8185 GB, free: 6.926 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008978/0.5484, allocations: 1.735 MB / 0.8202 GB, free: 5.184 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003737/0.5488, allocations: 95.81 kB / 0.8203 GB, free: 5.09 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01135/0.5602, allocations: 7.151 MB / 0.8273 GB, free: 13.65 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005804/0.5608, allocations: 24.05 kB / 0.8273 GB, free: 13.63 MB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.698e-05/0.5608, allocations: 47.92 kB / 0.8273 GB, free: 13.58 MB / 0.6544 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 9
 * 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 (46):
 * Single equations (assignments): 44
 * 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): 2 systems
   {(5,3,92.0%), (5,3,92.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0002671/0.5611, allocations: 208.9 kB / 0.8275 GB, free: 13.37 MB / 0.6544 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001604/0.5613, allocations: 82.97 kB / 0.8276 GB, free: 13.29 MB / 0.6544 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004723/0.566, allocations: 1.735 MB / 0.8293 GB, free: 11.55 MB / 0.6544 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.001e-06/0.566, allocations: 11.88 kB / 0.8293 GB, free: 11.54 MB / 0.6544 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.41e-06/0.566, allocations: 4 kB / 0.8293 GB, free: 11.53 MB / 0.6544 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.723e-06/0.566, allocations: 3.984 kB / 0.8293 GB, free: 11.53 MB / 0.6544 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00523/0.5713, allocations: 2.552 MB / 0.8318 GB, free: 8.891 MB / 0.6544 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.128e-06/0.5713, allocations: 4 kB / 0.8318 GB, free: 8.887 MB / 0.6544 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0003785/0.5717, allocations: 95.77 kB / 0.8319 GB, free: 8.793 MB / 0.6544 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003165/0.5749, allocations: 0.7994 MB / 0.8327 GB, free: 7.988 MB / 0.6544 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.607e-05/0.5749, allocations: 22.42 kB / 0.8327 GB, free: 7.969 MB / 0.6544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005998/0.5809, allocations: 4.854 MB / 0.8374 GB, free: 2.836 MB / 0.6544 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.988e-06/0.5809, allocations: 8.75 kB / 0.8375 GB, free: 2.828 MB / 0.6544 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004715/0.5856, allocations: 2.151 MB / 0.8396 GB, free: 0.6328 MB / 0.6544 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000276/0.5859, allocations: 236 kB / 0.8398 GB, free: 392 kB / 0.6544 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001088/0.5861, allocations: 12 kB / 0.8398 GB, free: 380 kB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000517/0.5866, allocations: 23.98 kB / 0.8398 GB, free: 356 kB / 0.6544 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001267/0.5867, allocations: 44.44 kB / 0.8399 GB, free: 312 kB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.057e-05/0.5868, allocations: 26.3 kB / 0.8399 GB, free: 288 kB / 0.6544 GB
Notification: Performance of sorting global known variables: time 0.0005191/0.5873, allocations: 0.5029 MB / 0.8404 GB, free: 15.78 MB / 0.67 GB
Notification: Performance of sort global known variables: time 1.21e-07/0.5873, allocations: 3.938 kB / 0.8404 GB, free: 15.78 MB / 0.67 GB
Notification: Performance of remove unused functions: time 0.0006947/0.588, allocations: 283.8 kB / 0.8406 GB, free: 15.5 MB / 0.67 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 7
 * Number of states: 4 (pow_m_flow.mExc,pow_V_flow.mExc,pow_1dat.mExc,pow_2dat.mExc)
 * 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 (49):
 * Single equations (assignments): 47
 * 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): 2 systems
   {(5,3,92.0%), (4,4,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.005254/0.5933, allocations: 2.8 MB / 0.8434 GB, free: 12.65 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.003178/0.5964, allocations: 1.515 MB / 0.8449 GB, free: 11.11 MB / 0.67 GB
Notification: Performance of simCode: created event and clocks part: time 4.108e-06/0.5965, allocations: 4 kB / 0.8449 GB, free: 11.11 MB / 0.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.001641/0.5981, allocations: 0.9186 MB / 0.8458 GB, free: 10.16 MB / 0.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001843/0.6, allocations: 463.5 kB / 0.8462 GB, free: 9.742 MB / 0.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.2121/0.812, allocations: 10.69 MB / 0.8566 GB, free: 209.3 MB / 0.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0002951/0.8123, allocations: 0.9829 MB / 0.8576 GB, free: 208.6 MB / 0.67 GB
Notification: Performance of simCode: alias equations: time 0.0006155/0.813, allocations: 150.7 kB / 0.8577 GB, free: 208.6 MB / 0.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002773/0.8133, allocations: 290.9 kB / 0.858 GB, free: 208.6 MB / 0.67 GB
Notification: Performance of SimCode: time 8.32e-07/0.8133, allocations: 0 / 0.858 GB, free: 208.6 MB / 0.67 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.07732/0.8906, allocations: 29.51 MB / 0.8868 GB, free: 207.1 MB / 0.67 GB
Notification: Performance of buildModelFMU: Generate platform static: time 8.446/9.337, allocations: 2.25 kB / 0.8868 GB, free: 207.1 MB / 0.67 GB
(rm -f BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.sim & python3 -m fmpy simulate  --output-file BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw_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_Airflow_Multizone_Examples_PowerLaw.fmu > BuildSysPro_BuildSysPro.IBPSA.Airflow.Multizone.Examples.PowerLaw.pipe 2>&1)