Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.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: translateModel(BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics")
translateModel(BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001156/0.001156, allocations: 110.9 kB / 16.42 MB, free: 6.492 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.001191/0.001191, allocations: 183.9 kB / 17.35 MB, free: 5.75 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.284/1.284, allocations: 222.9 MB / 241.1 MB, free: 15.19 MB / 206.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.8327/0.8327, allocations: 143.1 MB / 434.3 MB, free: 11.98 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001249/0.001249, allocations: 61.22 kB / 0.5962 GB, free: 12.45 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1313/0.1326, allocations: 82.03 MB / 0.6763 GB, free: 10.51 MB / 0.5137 GB
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics): time 0.3963/0.5289, allocations: 112.1 MB / 0.7858 GB, free: 3.91 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.03695/0.5659, allocations: 32.07 MB / 0.8171 GB, free: 5.43 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00483/0.5708, allocations: 156.1 kB / 0.8172 GB, free: 5.371 MB / 0.5919 GB
Notification: Performance of NFTyping.typeComponents: time 0.004136/0.575, allocations: 1.844 MB / 0.819 GB, free: 4.203 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.01143/0.5864, allocations: 4.851 MB / 0.8238 GB, free: 468 kB / 0.5919 GB
Notification: Performance of NFTyping.typeClassSections: time 0.008028/0.5944, allocations: 3.602 MB / 0.8273 GB, free: 13.6 MB / 0.6075 GB
Notification: Performance of NFFlatten.flatten: time 0.04272/0.6372, allocations: 47.76 MB / 0.8739 GB, free: 3.777 MB / 0.6387 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02663/0.6638, allocations: 23.75 MB / 0.8971 GB, free: 11.87 MB / 0.67 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02694/0.6908, allocations: 16.36 MB / 0.9131 GB, free: 11.56 MB / 0.6856 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02163/0.7125, allocations: 14.05 MB / 0.9268 GB, free: 13.46 MB / 0.7012 GB
Notification: Performance of NFPackage.collectConstants: time 0.006935/0.7194, allocations: 2.434 MB / 0.9292 GB, free: 11.02 MB / 0.7012 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01524/0.7347, allocations: 4.742 MB / 0.9338 GB, free: 6.277 MB / 0.7012 GB
Notification: Performance of NFScalarize.scalarize: time 0.009123/0.7438, allocations: 5.501 MB / 0.9392 GB, free: 0.7617 MB / 0.7012 GB
Notification: Performance of NFVerifyModel.verify: time 0.02113/0.765, allocations: 11.1 MB / 0.95 GB, free: 5.621 MB / 0.7169 GB
Notification: Performance of NFConvertDAE.convert: time 0.04428/0.8093, allocations: 36.61 MB / 0.9858 GB, free: 0.8984 MB / 0.7481 GB
Notification: Performance of FrontEnd - DAE generated: time 5.951e-06/0.8093, allocations: 0 / 0.9858 GB, free: 0.8984 MB / 0.7481 GB
Notification: Performance of FrontEnd: time 1.914e-06/0.8093, allocations: 0 / 0.9858 GB, free: 0.8984 MB / 0.7481 GB
Notification: Performance of Transformations before backend: time 0.0009691/0.8103, allocations: 0 / 0.9858 GB, free: 0.8984 MB / 0.7481 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3345
 * Number of variables: 3345
Notification: Performance of Generate backend data structure: time 0.05425/0.8646, allocations: 20.35 MB / 1.006 GB, free: 12.39 MB / 0.7794 GB
Notification: Performance of prepare preOptimizeDAE: time 5.566e-05/0.8647, allocations: 8.031 kB / 1.006 GB, free: 12.38 MB / 0.7794 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01153/0.8762, allocations: 2.063 MB / 1.008 GB, free: 10.31 MB / 0.7794 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03201/0.9082, allocations: 16.5 MB / 1.024 GB, free: 9.727 MB / 0.795 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007958/0.9091, allocations: 1.002 MB / 1.025 GB, free: 8.723 MB / 0.795 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003948/0.913, allocations: 1.332 MB / 1.026 GB, free: 7.391 MB / 0.795 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03722/0.9502, allocations: 20.26 MB / 1.046 GB, free: 2.57 MB / 0.8106 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003/0.9506, allocations: 43.7 kB / 1.046 GB, free: 2.527 MB / 0.8106 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001637/0.9522, allocations: 0.539 MB / 1.046 GB, free: 1.988 MB / 0.8106 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003042/0.9525, allocations: 383.9 kB / 1.047 GB, free: 1.613 MB / 0.8106 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.5779/1.53, allocations: 18.15 MB / 1.064 GB, free: 272.6 MB / 0.8263 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.1012/1.632, allocations: 86.71 MB / 1.149 GB, free: 210.9 MB / 0.8263 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01494/1.647, allocations: 12.97 MB / 1.162 GB, free: 203.8 MB / 0.8263 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.007592/1.654, allocations: 7.389 MB / 1.169 GB, free: 197.8 MB / 0.8263 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 evalFunc (simulation): time 0.03777/1.692, allocations: 27.03 MB / 1.195 GB, free: 170.1 MB / 0.8263 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007227/1.699, allocations: 6.06 MB / 1.201 GB, free: 164 MB / 0.8263 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.00465/1.704, allocations: 0.8412 MB / 1.202 GB, free: 163.4 MB / 0.8263 GB
Notification: Performance of pre-optimization done (n=772): time 1.332e-05/1.704, allocations: 0 / 1.202 GB, free: 163.4 MB / 0.8263 GB
Notification: Performance of matching and sorting (n=772): time 0.08937/1.793, allocations: 32.42 MB / 1.234 GB, free: 130.9 MB / 0.8263 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.357e-05/1.793, allocations: 166.9 kB / 1.234 GB, free: 130.7 MB / 0.8263 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01464/1.808, allocations: 12.85 MB / 1.247 GB, free: 118 MB / 0.8263 GB
Notification: Performance of collectPreVariables (initialization): time 0.001311/1.809, allocations: 201.7 kB / 1.247 GB, free: 117.8 MB / 0.8263 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004851/1.814, allocations: 7.199 MB / 1.254 GB, free: 111.3 MB / 0.8263 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002493/1.817, allocations: 2.833 MB / 1.257 GB, free: 108.8 MB / 0.8263 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002809/1.82, allocations: 2.318 MB / 1.259 GB, free: 106.5 MB / 0.8263 GB
Notification: Performance of setup shared object (initialization): time 3.439e-05/1.82, allocations: 309.1 kB / 1.259 GB, free: 106.1 MB / 0.8263 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00733/1.827, allocations: 6.333 MB / 1.265 GB, free: 99.8 MB / 0.8263 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.008392/1.835, allocations: 9.594 MB / 1.275 GB, free: 88.82 MB / 0.8263 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01583/1.851, allocations: 15.95 MB / 1.29 GB, free: 71.41 MB / 0.8263 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.299e-05/1.851, allocations: 28 kB / 1.29 GB, free: 71.38 MB / 0.8263 GB
Notification: Performance of matching and sorting (n=1474) (initialization): time 0.02443/1.876, allocations: 18.94 MB / 1.309 GB, free: 52.32 MB / 0.8263 GB
Notification: Performance of prepare postOptimizeDAE: time 6.765e-05/1.876, allocations: 73.7 kB / 1.309 GB, free: 52.25 MB / 0.8263 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.984e-05/1.876, allocations: 100.9 kB / 1.309 GB, free: 52.15 MB / 0.8263 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.05804/1.934, allocations: 9.119 MB / 1.318 GB, free: 43.02 MB / 0.8263 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009032/1.943, allocations: 2.457 MB / 1.32 GB, free: 40.55 MB / 0.8263 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009602/1.953, allocations: 10.82 MB / 1.331 GB, free: 29.44 MB / 0.8263 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01043/1.963, allocations: 0.7335 MB / 1.332 GB, free: 28.7 MB / 0.8263 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001548/1.965, allocations: 0.5194 MB / 1.332 GB, free: 28.18 MB / 0.8263 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01517/1.98, allocations: 11.72 MB / 1.343 GB, free: 16.45 MB / 0.8263 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.009056/1.989, allocations: 9.59 MB / 1.353 GB, free: 5.473 MB / 0.8263 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01992/2.009, allocations: 15.95 MB / 1.368 GB, free: 4.059 MB / 0.8419 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.019e-05/2.009, allocations: 28 kB / 1.368 GB, free: 4.031 MB / 0.8419 GB
Notification: Performance of matching and sorting (n=1474) (initialization_lambda0): time 0.03134/2.04, allocations: 18.93 MB / 1.387 GB, free: 0.9844 MB / 0.8575 GB
Notification: Performance of prepare postOptimizeDAE: time 8.093e-05/2.04, allocations: 77.73 kB / 1.387 GB, free: 0.9023 MB / 0.8575 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001068/2.04, allocations: 100 kB / 1.387 GB, free: 0.8047 MB / 0.8575 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.6179/2.658, allocations: 9.113 MB / 1.396 GB, free: 287.8 MB / 0.8577 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01049/2.669, allocations: 2.453 MB / 1.398 GB, free: 287.8 MB / 0.8577 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01131/2.68, allocations: 10.83 MB / 1.409 GB, free: 284.2 MB / 0.8577 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01029/2.691, allocations: 0.7238 MB / 1.41 GB, free: 284 MB / 0.8577 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001302/2.692, allocations: 0.5194 MB / 1.41 GB, free: 283.9 MB / 0.8577 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 448
 * Number of states: 0 ()
 * Number of discrete variables: 5 (mHex_flow_in.count,$PRE.mHex_flow_in.count,mHex_flow_in.T_start,$PRE.mHex_flow_in.T_start,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1286):
 * Single equations (assignments): 1282
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,14,100.0%), (1,14,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(16,144)}
Notification: Performance of prepare postOptimizeDAE: time 0.002167/2.694, allocations: 0.8573 MB / 1.411 GB, free: 283.3 MB / 0.8577 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004039/2.698, allocations: 1.226 MB / 1.412 GB, free: 283.3 MB / 0.8577 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01818/2.716, allocations: 13.38 MB / 1.425 GB, free: 278.1 MB / 0.8577 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0139/2.73, allocations: 11.05 MB / 1.436 GB, free: 273.9 MB / 0.8577 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.983e-05/2.73, allocations: 0 / 1.436 GB, free: 273.9 MB / 0.8577 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006134/2.736, allocations: 2.84 MB / 1.439 GB, free: 272.8 MB / 0.8577 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002272/2.739, allocations: 162.3 kB / 1.439 GB, free: 272.7 MB / 0.8577 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006199/2.745, allocations: 464.6 kB / 1.439 GB, free: 272.6 MB / 0.8577 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008589/2.746, allocations: 467.1 kB / 1.44 GB, free: 272.5 MB / 0.8577 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02128/2.767, allocations: 14.33 MB / 1.454 GB, free: 262.2 MB / 0.8577 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.02092/2.788, allocations: 18.99 MB / 1.472 GB, free: 243.2 MB / 0.8577 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.005236/2.793, allocations: 5.514 MB / 1.478 GB, free: 237.6 MB / 0.8577 GB
Notification: Performance of sorting global known variables: time 0.01086/2.804, allocations: 8.915 MB / 1.487 GB, free: 228.7 MB / 0.8577 GB
Notification: Performance of Backend: time 3e-07/2.804, allocations: 0 / 1.487 GB, free: 228.7 MB / 0.8577 GB
Notification: Performance of simCode: created initialization part: time 0.02963/2.834, allocations: 19.81 MB / 1.506 GB, free: 209.1 MB / 0.8577 GB
Notification: Performance of SimCode: time 0.05236/2.886, allocations: 36.56 MB / 1.542 GB, free: 172.8 MB / 0.8577 GB
Notification: Performance of Templates: time 0.6837/3.57, allocations: 334.9 MB / 1.869 GB, free: 156.8 MB / 0.8577 GB
make -j1 -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.makefile
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.sim & ./BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics  -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildSysPro_BuildSysPro.IBPSA.Fluid.Storage.Validation.HeatExchangerDynamics.pipe 2>&1)