Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_Buildings.ThermalZones.EnergyPlus_9_6_0.Examples.SingleFamilyHouse.HeatPumpRadiantHeatingGroundHeatTransfer.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001386/0.001386, allocations: 109 kB / 17.54 MB, free: 4.746 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001437/0.001437, allocations: 185.9 kB / 20.71 MB, free: 1.586 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.301/1.301, allocations: 225.6 MB / 249.3 MB, free: 3.152 MB / 190.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo): time 2.367/2.367, allocations: 443.5 MB / 0.7304 GB, free: 14 MB / 0.5762 GB
"
[Timeout remaining time 177]
Using package Buildings with version 10.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/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(Buildings.ThermalZones.EnergyPlus_9_6_0.Examples.SingleFamilyHouse.HeatPumpRadiantHeatingGroundHeatTransfer,fileNamePrefix="Buildings_10_Buildings_ThermalZones_EnergyPlus_9_6_0_Examples_SingleFamilyHouse_HeatPumpRadiantHeatingGroundHeatTransfer",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.ThermalZones.EnergyPlus_9_6_0.Examples.SingleFamilyHouse.HeatPumpRadiantHeatingGroundHeatTransfer,fileNamePrefix="Buildings_10_Buildings_ThermalZones_EnergyPlus_9_6_0_Examples_SingleFamilyHouse_HeatPumpRadiantHeatingGroundHeatTransfer",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.001876/0.001876, allocations: 63.89 kB / 1.059 GB, free: 0.9297 MB / 0.795 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2524/0.2543, allocations: 160.7 MB / 1.216 GB, free: 15.89 MB / 0.9669 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.EnergyPlus_9_6_0.Examples.SingleFamilyHouse.HeatPumpRadiantHeatingGroundHeatTransfer): time 0.8949/1.149, allocations: 406.3 MB / 1.612 GB, free: 9.215 MB / 1.279 GB
Notification: Performance of NFInst.instExpressions: time 0.09777/1.247, allocations: 70.55 MB / 1.681 GB, free: 2.477 MB / 1.342 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0115/1.258, allocations: 322.2 kB / 1.682 GB, free: 2.16 MB / 1.342 GB
Notification: Performance of NFTyping.typeComponents: time 0.0149/1.273, allocations: 5.766 MB / 1.687 GB, free: 12.36 MB / 1.357 GB
Notification: Performance of NFTyping.typeBindings: time 0.03092/1.304, allocations: 12.29 MB / 1.699 GB, free: 40 kB / 1.357 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/Fluid/Geothermal/Boreholes/BaseClasses/temperatureDrop.mo:2:1-109:20:writable] Warning: Pure function 'Buildings.Fluid.Geothermal.Boreholes.BaseClasses.temperatureDrop' contains a call to impure function 'Buildings.Fluid.Geothermal.Boreholes.BaseClasses.exchangeValues'.
Notification: Performance of NFTyping.typeClassSections: time 0.02/1.324, allocations: 8.483 MB / 1.708 GB, free: 7.598 MB / 1.373 GB
Notification: Performance of NFFlatten.flatten: time 0.1035/1.428, allocations: 84.39 MB / 1.79 GB, free: 3.031 MB / 1.451 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0411/1.469, allocations: 23.4 MB / 1.813 GB, free: 11.45 MB / 1.482 GB
Notification: Performance of NFEvalConstants.evaluate: time 1.28/2.748, allocations: 29.71 MB / 1.842 GB, free: 75.25 MB / 1.483 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0378/2.786, allocations: 23.01 MB / 1.864 GB, free: 73.8 MB / 1.483 GB
Notification: Performance of NFPackage.collectConstants: time 0.0137/2.8, allocations: 4.249 MB / 1.868 GB, free: 73.8 MB / 1.483 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.03441/2.834, allocations: 14.01 MB / 1.882 GB, free: 73.79 MB / 1.483 GB
Notification: Performance of NFScalarize.scalarize: time 0.01721/2.852, allocations: 11.01 MB / 1.893 GB, free: 72.57 MB / 1.483 GB
Notification: Performance of NFVerifyModel.verify: time 0.03525/2.887, allocations: 19.15 MB / 1.912 GB, free: 68.35 MB / 1.483 GB
Notification: Performance of NFConvertDAE.convert: time 0.06787/2.955, allocations: 64.66 MB / 1.975 GB, free: 58.81 MB / 1.483 GB
Notification: Performance of FrontEnd - DAE generated: time 6.622e-06/2.955, allocations: 1.125 kB / 1.975 GB, free: 58.81 MB / 1.483 GB
Notification: Performance of FrontEnd: time 1.753e-06/2.955, allocations: 0 / 1.975 GB, free: 58.81 MB / 1.483 GB
Notification: Performance of Transformations before backend: time 0.001502/2.956, allocations: 0 / 1.975 GB, free: 58.81 MB / 1.483 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 4141
 * Number of variables: 4141
Notification: Performance of Generate backend data structure: time 0.09955/3.056, allocations: 38.84 MB / 2.013 GB, free: 39.69 MB / 1.483 GB
Notification: Performance of prepare preOptimizeDAE: time 4.506e-05/3.056, allocations: 11.03 kB / 2.013 GB, free: 39.69 MB / 1.483 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.008389/3.064, allocations: 2.181 MB / 2.015 GB, free: 39.16 MB / 1.483 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02663/3.091, allocations: 4.658 MB / 2.019 GB, free: 37.01 MB / 1.483 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.06736/3.158, allocations: 38.61 MB / 2.057 GB, free: 21.67 MB / 1.483 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001437/3.16, allocations: 1.505 MB / 2.058 GB, free: 20.43 MB / 1.483 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.008801/3.168, allocations: 1.977 MB / 2.06 GB, free: 18.45 MB / 1.483 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05776/3.226, allocations: 24.94 MB / 2.085 GB, free: 9.016 MB / 1.498 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000801/3.227, allocations: 57.61 kB / 2.085 GB, free: 8.977 MB / 1.498 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.005648/3.233, allocations: 0.6635 MB / 2.085 GB, free: 8.316 MB / 1.498 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000558/3.233, allocations: 0.5919 MB / 2.086 GB, free: 7.727 MB / 1.498 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0559/3.289, allocations: 22.35 MB / 2.108 GB, free: 1.492 MB / 1.514 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.2508/3.54, allocations: 132.8 MB / 2.238 GB, free: 7.984 MB / 1.654 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.05666/3.597, allocations: 23.74 MB / 2.261 GB, free: 492 kB / 1.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02109/3.618, allocations: 9.431 MB / 2.27 GB, free: 7.035 MB / 1.686 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.1548/3.772, allocations: 59.19 MB / 2.328 GB, free: 11.46 MB / 1.748 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0222/3.795, allocations: 9.767 MB / 2.337 GB, free: 1.617 MB / 1.748 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01211/3.807, allocations: 1.227 MB / 2.338 GB, free: 392 kB / 1.748 GB
Notification: Performance of pre-optimization done (n=1172): time 2.443e-05/3.807, allocations: 0 / 2.338 GB, free: 392 kB / 1.748 GB
Notification: Performance of matching and sorting (n=1172): time 0.09981/3.907, allocations: 33.16 MB / 2.371 GB, free: 14.5 MB / 1.795 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0004084/3.907, allocations: 0.5813 MB / 2.371 GB, free: 13.82 MB / 1.795 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.05378/3.961, allocations: 24.71 MB / 2.396 GB, free: 5.242 MB / 1.811 GB
Notification: Performance of collectPreVariables (initialization): time 0.004865/3.966, allocations: 425.3 kB / 2.396 GB, free: 4.824 MB / 1.811 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01872/3.984, allocations: 11.2 MB / 2.407 GB, free: 9.727 MB / 1.826 GB
Notification: Performance of collectInitialBindings (initialization): time 0.008922/3.993, allocations: 4.374 MB / 2.411 GB, free: 5.41 MB / 1.826 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01938/4.013, allocations: 4.553 MB / 2.416 GB, free: 0.8477 MB / 1.826 GB
Notification: Performance of setup shared object (initialization): time 0.0001121/4.013, allocations: 301.1 kB / 2.416 GB, free: 0.5508 MB / 1.826 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.03068/4.043, allocations: 14.44 MB / 2.43 GB, free: 2.094 MB / 1.842 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03668/4.08, allocations: 19.01 MB / 2.449 GB, free: 13.46 MB / 1.873 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.05635/4.137, allocations: 27.83 MB / 2.476 GB, free: 0.5703 MB / 1.889 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001263/4.137, allocations: 28 kB / 2.476 GB, free: 0.543 MB / 1.889 GB
Notification: Performance of matching and sorting (n=2597) (initialization): time 0.616/4.753, allocations: 39.09 MB / 2.514 GB, free: 0.8087 GB / 1.904 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001545/4.753, allocations: 103.3 kB / 2.514 GB, free: 0.8087 GB / 1.904 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003244/4.753, allocations: 117.7 kB / 2.514 GB, free: 0.8087 GB / 1.904 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0086/4.762, allocations: 3.371 MB / 2.517 GB, free: 0.8084 GB / 1.904 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02436/4.786, allocations: 4.973 MB / 2.522 GB, free: 0.8084 GB / 1.904 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04366/4.83, allocations: 69.19 MB / 2.59 GB, free: 0.7564 GB / 1.904 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0409/4.871, allocations: 4.398 MB / 2.594 GB, free: 0.7561 GB / 1.904 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005861/4.877, allocations: 0.852 MB / 2.595 GB, free: 0.756 GB / 1.904 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.04178/4.918, allocations: 22.74 MB / 2.617 GB, free: 0.7478 GB / 1.904 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0306/4.949, allocations: 18.79 MB / 2.636 GB, free: 0.7383 GB / 1.904 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.04423/4.993, allocations: 27.43 MB / 2.662 GB, free: 0.7252 GB / 1.904 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001583/4.993, allocations: 28.62 kB / 2.662 GB, free: 0.7252 GB / 1.904 GB
Notification: Performance of matching and sorting (n=2597) (initialization_lambda0): time 0.08394/5.077, allocations: 38.75 MB / 2.7 GB, free: 0.7109 GB / 1.904 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000123/5.077, allocations: 101.9 kB / 2.7 GB, free: 0.7108 GB / 1.904 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002558/5.078, allocations: 119.2 kB / 2.7 GB, free: 0.7107 GB / 1.904 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007367/5.085, allocations: 3.398 MB / 2.704 GB, free: 0.7079 GB / 1.904 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02209/5.107, allocations: 4.95 MB / 2.709 GB, free: 0.7042 GB / 1.904 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04348/5.151, allocations: 73.76 MB / 2.781 GB, free: 0.6284 GB / 1.904 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04106/5.192, allocations: 4.504 MB / 2.785 GB, free: 0.6242 GB / 1.904 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005597/5.197, allocations: 0.8356 MB / 2.786 GB, free: 0.6233 GB / 1.904 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 446
 * Number of states: 0 ()
 * Number of discrete variables: 159 (borHol.borHol[1].TBouCon.iSam,$PRE.borHol.borHol[1].TBouCon.iSam,borHol.borHol[1].TBouCon.UOld,$PRE.borHol.borHol[1].TBouCon.UOld,borHol.borHol[1].TBouCon.QAve_flow,$PRE.borHol.borHol[1].TBouCon.QAve_flow,borHol.borHol[2].TBouCon.iSam,$PRE.borHol.borHol[2].TBouCon.iSam,borHol.borHol[2].TBouCon.UOld,$PRE.borHol.borHol[2].TBouCon.UOld,borHol.borHol[2].TBouCon.QAve_flow,$PRE.borHol.borHol[2].TBouCon.QAve_flow,borHol.borHol[3].TBouCon.iSam,$PRE.borHol.borHol[3].TBouCon.iSam,borHol.borHol[3].TBouCon.UOld,$PRE.borHol.borHol[3].TBouCon.UOld,borHol.borHol[3].TBouCon.QAve_flow,$PRE.borHol.borHol[3].TBouCon.QAve_flow,borHol.borHol[4].TBouCon.iSam,$PRE.borHol.borHol[4].TBouCon.iSam,borHol.borHol[4].TBouCon.UOld,$PRE.borHol.borHol[4].TBouCon.UOld,borHol.borHol[4].TBouCon.QAve_flow,$PRE.borHol.borHol[4].TBouCon.QAve_flow,borHol.borHol[5].TBouCon.iSam,$PRE.borHol.borHol[5].TBouCon.iSam,borHol.borHol[5].TBouCon.UOld,$PRE.borHol.borHol[5].TBouCon.UOld,borHol.borHol[5].TBouCon.QAve_flow,$PRE.borHol.borHol[5].TBouCon.QAve_flow,borHol.borHol[6].TBouCon.iSam,$PRE.borHol.borHol[6].TBouCon.iSam,borHol.borHol[6].TBouCon.UOld,$PRE.borHol.borHol[6].TBouCon.UOld,borHol.borHol[6].TBouCon.QAve_flow,$PRE.borHol.borHol[6].TBouCon.QAve_flow,borHol.borHol[7].TBouCon.iSam,$PRE.borHol.borHol[7].TBouCon.iSam,borHol.borHol[7].TBouCon.UOld,$PRE.borHol.borHol[7].TBouCon.UOld,borHol.borHol[7].TBouCon.QAve_flow,$PRE.borHol.borHol[7].TBouCon.QAve_flow,borHol.borHol[8].TBouCon.iSam,$PRE.borHol.borHol[8].TBouCon.iSam,borHol.borHol[8].TBouCon.UOld,$PRE.borHol.borHol[8].TBouCon.UOld,borHol.borHol[8].TBouCon.QAve_flow,$PRE.borHol.borHol[8].TBouCon.QAve_flow,borHol.borHol[9].TBouCon.iSam,$PRE.borHol.borHol[9].TBouCon.iSam,borHol.borHol[9].TBouCon.UOld,$PRE.borHol.borHol[9].TBouCon.UOld,borHol.borHol[9].TBouCon.QAve_flow,$PRE.borHol.borHol[9].TBouCon.QAve_flow,borHol.borHol[10].TBouCon.iSam,$PRE.borHol.borHol[10].TBouCon.iSam,borHol.borHol[10].TBouCon.UOld,$PRE.borHol.borHol[10].TBouCon.UOld,borHol.borHol[10].TBouCon.QAve_flow,$PRE.borHol.borHol[10].TBouCon.QAve_flow,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition1,$whenCondition2,zon.fmuZon.tLast,livFlo.tLast,EEle.local_reset,EHea.local_reset,conSup.cheYMinMax.y,conHea.conHea.cheYMinMax.y,livFlo.nObj,zon.vol.computeCSen,zon.fmuZon.nObj,onHeaPum.y,ava.y,$PRE.ava.y,borHol.borHol[10].TBouCon.port.T,$PRE.borHol.borHol[10].TBouCon.port.T,borHol.borHol[9].TBouCon.port.T,$PRE.borHol.borHol[9].TBouCon.port.T,borHol.borHol[8].TBouCon.port.T,$PRE.borHol.borHol[8].TBouCon.port.T,borHol.borHol[7].TBouCon.port.T,$PRE.borHol.borHol[7].TBouCon.port.T,borHol.borHol[6].TBouCon.port.T,$PRE.borHol.borHol[6].TBouCon.port.T,borHol.borHol[5].TBouCon.port.T,$PRE.borHol.borHol[5].TBouCon.port.T,borHol.borHol[4].TBouCon.port.T,$PRE.borHol.borHol[4].TBouCon.port.T,borHol.borHol[3].TBouCon.port.T,$PRE.borHol.borHol[3].TBouCon.port.T,borHol.borHol[2].TBouCon.port.T,$PRE.borHol.borHol[2].TBouCon.port.T,borHol.borHol[1].TBouCon.port.T,$PRE.borHol.borHol[1].TBouCon.port.T,heaPum.temPro.hysdTConEva.y,$PRE.heaPum.temPro.hysdTConEva.y,heaPum.temPro.on.y,heaPum.temPro.hysLow.y,$PRE.heaPum.temPro.hysLow.y,heaPum.temPro.hysHig.y,$PRE.heaPum.temPro.hysHig.y,heaPum.com.isOn,$PRE.heaPum.com.isOn,conHea.hysHea.y,$PRE.conHea.hysHea.y,livFlo.QLast_flow,livFlo.TLast,livFlo.dtLast,$PRE.livFlo.tLast,livFlo.tNext,$PRE.livFlo.tNext,livFlo.yEP[2],livFlo.yEP[1],zon.fmuZon.QConLast_flow,zon.fmuZon.TRooLast,zon.fmuZon.TAveInlet,$PRE.zon.fmuZon.TAveInlet,zon.fmuZon.mInlet_flow,$PRE.zon.fmuZon.mInlet_flow,zon.fmuZon.dtLast,$PRE.zon.fmuZon.tLast,zon.fmuZon.tNext,$PRE.zon.fmuZon.tNext,zon.fmuZon.yEP[5],zon.fmuZon.yEP[4],zon.fmuZon.yEP[3],zon.fmuZon.yEP[2],zon.fmuZon.yEP[1],zon.fmuZon.QPeo_flow,zon.fmuZon.QLat_flow,zon.fmuZon.TRad,building.weaDat.decAng.tNext,$PRE.building.weaDat.decAng.tNext,building.weaDat.eqnTim.tNext,$PRE.building.weaDat.eqnTim.tNext,building.weaDat.conTim.tNext,$PRE.building.weaDat.conTim.tNext,building.weaDat.conTimMin.tNext,$PRE.building.weaDat.conTimMin.tNext,building.weaDat.locTim.tNext,$PRE.building.weaDat.locTim.tNext,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2305):
 * Single equations (assignments): 2250
 * Array equations: 6
 * Algorithm blocks: 1
 * Record equations: 12
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 36
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 32 systems
   {(1,1,100.0%), (18,19,16.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 4 systems
   {(2,19), (1,5), (2,8), (1,6)}
Notification: Performance of prepare postOptimizeDAE: time 0.0083/5.206, allocations: 1.38 MB / 2.787 GB, free: 0.622 GB / 1.904 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.007315/5.213, allocations: 2.161 MB / 2.789 GB, free: 0.6199 GB / 1.904 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04545/5.258, allocations: 21.05 MB / 2.81 GB, free: 0.5993 GB / 1.904 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.486e-05/5.258, allocations: 112 kB / 2.81 GB, free: 0.5992 GB / 1.904 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.9e-05/5.258, allocations: 21.86 kB / 2.81 GB, free: 0.5992 GB / 1.904 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.03552/5.294, allocations: 17.29 MB / 2.827 GB, free: 0.5822 GB / 1.904 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.09559/5.39, allocations: 50.61 MB / 2.876 GB, free: 0.5327 GB / 1.904 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.902e-05/5.39, allocations: 0 / 2.876 GB, free: 0.5327 GB / 1.904 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0116/5.401, allocations: 2.329 MB / 2.879 GB, free: 0.5305 GB / 1.904 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.005481/5.407, allocations: 2.518 MB / 2.881 GB, free: 0.5279 GB / 1.904 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.00297/5.41, allocations: 0.4957 MB / 2.881 GB, free: 0.5274 GB / 1.904 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03258/5.442, allocations: 64.19 MB / 2.944 GB, free: 471.4 MB / 1.904 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.947e-06/5.442, allocations: 12 kB / 2.944 GB, free: 471.4 MB / 1.904 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.06216/5.504, allocations: 31.2 MB / 2.975 GB, free: 439.9 MB / 1.904 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01334/5.518, allocations: 5.052 MB / 2.98 GB, free: 434.9 MB / 1.904 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006951/5.525, allocations: 471.7 kB / 2.98 GB, free: 434.4 MB / 1.904 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02284/5.548, allocations: 2.088 MB / 2.982 GB, free: 432.3 MB / 1.904 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003117/5.551, allocations: 0.7656 MB / 2.983 GB, free: 431.6 MB / 1.904 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002292/5.553, allocations: 463.6 kB / 2.983 GB, free: 431.1 MB / 1.904 GB
Notification: Performance of sorting global known variables: time 0.03011/5.583, allocations: 16.99 MB / 3 GB, free: 414.2 MB / 1.904 GB
Notification: Performance of sort global known variables: time 2.11e-07/5.583, allocations: 4 kB / 3 GB, free: 414.2 MB / 1.904 GB
Notification: Performance of remove unused functions: time 0.06142/5.644, allocations: 19.23 MB / 3.019 GB, free: 395.9 MB / 1.904 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 10
 * Number of states: 190 (zon.vol.medium.Xi[1],zon.vol.U,zon.vol.m,slaFlo.sla.vol[1].dynBal.U,slaFlo.sla.con_a[1].lay[1].T[1],slaFlo.sla.con_a[1].lay[1].T[2],slaFlo.sla.con_b[1].lay[1].T[1],slaFlo.sla.con_b[1].lay[1].T[2],slaFlo.sla.con_b[1].lay[1].T[3],slaFlo.sla.con_b[1].lay[2].T[1],slaFlo.sla.con_b[1].lay[2].T[2],slaFlo.sla.con_b[1].lay[2].T[3],pum.filter.s[1],pum.filter.s[2],soi.T[1],soi.T[2],soi.T[3],soi.T[4],soi.T[5],soi.T[6],soi.T[7],soi.T[8],soi.T[9],soi.T[10],soi.T[11],soi.T[12],soi.T[13],soi.T[14],soi.T[15],soi.T[16],soi.T[17],soi.T[18],conSup.I.y,heaPum.con.vol.dynBal.U,heaPum.eva.vol.dynBal.U,pumBor.filter.s[1],pumBor.filter.s[2],borHol.borHol[1].pipFil.vol1.dynBal.U,borHol.borHol[1].pipFil.vol2.dynBal.U,borHol.borHol[1].pipFil.capFil1.T,borHol.borHol[1].pipFil.capFil2.T,borHol.borHol[1].soi.T[1],borHol.borHol[1].soi.T[2],borHol.borHol[1].soi.T[3],borHol.borHol[1].soi.T[4],borHol.borHol[1].soi.T[5],borHol.borHol[1].soi.T[6],borHol.borHol[1].soi.T[7],borHol.borHol[1].soi.T[8],borHol.borHol[1].soi.T[9],borHol.borHol[1].soi.T[10],borHol.borHol[1].TBouCon.U,borHol.borHol[2].pipFil.vol1.dynBal.U,borHol.borHol[2].pipFil.vol2.dynBal.U,borHol.borHol[2].pipFil.capFil1.T,borHol.borHol[2].pipFil.capFil2.T,borHol.borHol[2].soi.T[1],borHol.borHol[2].soi.T[2],borHol.borHol[2].soi.T[3],borHol.borHol[2].soi.T[4],borHol.borHol[2].soi.T[5],borHol.borHol[2].soi.T[6],borHol.borHol[2].soi.T[7],borHol.borHol[2].soi.T[8],borHol.borHol[2].soi.T[9],borHol.borHol[2].soi.T[10],borHol.borHol[2].TBouCon.U,borHol.borHol[3].pipFil.vol1.dynBal.U,borHol.borHol[3].pipFil.vol2.dynBal.U,borHol.borHol[3].pipFil.capFil1.T,borHol.borHol[3].pipFil.capFil2.T,borHol.borHol[3].soi.T[1],borHol.borHol[3].soi.T[2],borHol.borHol[3].soi.T[3],borHol.borHol[3].soi.T[4],borHol.borHol[3].soi.T[5],borHol.borHol[3].soi.T[6],borHol.borHol[3].soi.T[7],borHol.borHol[3].soi.T[8],borHol.borHol[3].soi.T[9],borHol.borHol[3].soi.T[10],borHol.borHol[3].TBouCon.U,borHol.borHol[4].pipFil.vol1.dynBal.U,borHol.borHol[4].pipFil.vol2.dynBal.U,borHol.borHol[4].pipFil.capFil1.T,borHol.borHol[4].pipFil.capFil2.T,borHol.borHol[4].soi.T[1],borHol.borHol[4].soi.T[2],borHol.borHol[4].soi.T[3],borHol.borHol[4].soi.T[4],borHol.borHol[4].soi.T[5],borHol.borHol[4].soi.T[6],borHol.borHol[4].soi.T[7],borHol.borHol[4].soi.T[8],borHol.borHol[4].soi.T[9],borHol.borHol[4].soi.T[10],borHol.borHol[4].TBouCon.U,borHol.borHol[5].pipFil.vol1.dynBal.U,borHol.borHol[5].pipFil.vol2.dynBal.U,borHol.borHol[5].pipFil.capFil1.T,borHol.borHol[5].pipFil.capFil2.T,borHol.borHol[5].soi.T[1],borHol.borHol[5].soi.T[2],borHol.borHol[5].soi.T[3],borHol.borHol[5].soi.T[4],borHol.borHol[5].soi.T[5],borHol.borHol[5].soi.T[6],borHol.borHol[5].soi.T[7],borHol.borHol[5].soi.T[8],borHol.borHol[5].soi.T[9],borHol.borHol[5].soi.T[10],borHol.borHol[5].TBouCon.U,borHol.borHol[6].pipFil.vol1.dynBal.U,borHol.borHol[6].pipFil.vol2.dynBal.U,borHol.borHol[6].pipFil.capFil1.T,borHol.borHol[6].pipFil.capFil2.T,borHol.borHol[6].soi.T[1],borHol.borHol[6].soi.T[2],borHol.borHol[6].soi.T[3],borHol.borHol[6].soi.T[4],borHol.borHol[6].soi.T[5],borHol.borHol[6].soi.T[6],borHol.borHol[6].soi.T[7],borHol.borHol[6].soi.T[8],borHol.borHol[6].soi.T[9],borHol.borHol[6].soi.T[10],borHol.borHol[6].TBouCon.U,borHol.borHol[7].pipFil.vol1.dynBal.U,borHol.borHol[7].pipFil.vol2.dynBal.U,borHol.borHol[7].pipFil.capFil1.T,borHol.borHol[7].pipFil.capFil2.T,borHol.borHol[7].soi.T[1],borHol.borHol[7].soi.T[2],borHol.borHol[7].soi.T[3],borHol.borHol[7].soi.T[4],borHol.borHol[7].soi.T[5],borHol.borHol[7].soi.T[6],borHol.borHol[7].soi.T[7],borHol.borHol[7].soi.T[8],borHol.borHol[7].soi.T[9],borHol.borHol[7].soi.T[10],borHol.borHol[7].TBouCon.U,borHol.borHol[8].pipFil.vol1.dynBal.U,borHol.borHol[8].pipFil.vol2.dynBal.U,borHol.borHol[8].pipFil.capFil1.T,borHol.borHol[8].pipFil.capFil2.T,borHol.borHol[8].soi.T[1],borHol.borHol[8].soi.T[2],borHol.borHol[8].soi.T[3],borHol.borHol[8].soi.T[4],borHol.borHol[8].soi.T[5],borHol.borHol[8].soi.T[6],borHol.borHol[8].soi.T[7],borHol.borHol[8].soi.T[8],borHol.borHol[8].soi.T[9],borHol.borHol[8].soi.T[10],borHol.borHol[8].TBouCon.U,borHol.borHol[9].pipFil.vol1.dynBal.U,borHol.borHol[9].pipFil.vol2.dynBal.U,borHol.borHol[9].pipFil.capFil1.T,borHol.borHol[9].pipFil.capFil2.T,borHol.borHol[9].soi.T[1],borHol.borHol[9].soi.T[2],borHol.borHol[9].soi.T[3],borHol.borHol[9].soi.T[4],borHol.borHol[9].soi.T[5],borHol.borHol[9].soi.T[6],borHol.borHol[9].soi.T[7],borHol.borHol[9].soi.T[8],borHol.borHol[9].soi.T[9],borHol.borHol[9].soi.T[10],borHol.borHol[9].TBouCon.U,borHol.borHol[10].pipFil.vol1.dynBal.U,borHol.borHol[10].pipFil.vol2.dynBal.U,borHol.borHol[10].pipFil.capFil1.T,borHol.borHol[10].pipFil.capFil2.T,borHol.borHol[10].soi.T[1],borHol.borHol[10].soi.T[2],borHol.borHol[10].soi.T[3],borHol.borHol[10].soi.T[4],borHol.borHol[10].soi.T[5],borHol.borHol[10].soi.T[6],borHol.borHol[10].soi.T[7],borHol.borHol[10].soi.T[8],borHol.borHol[10].soi.T[9],borHol.borHol[10].soi.T[10],borHol.borHol[10].TBouCon.U,EHea.y,EEle.y,firOrdTRad.y)
 * Number of discrete variables: 95 (onHeaPum.y,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition1,$whenCondition2,building.weaDat.locTim.tNext,building.weaDat.conTimMin.tNext,building.weaDat.conTim.tNext,building.weaDat.eqnTim.tNext,building.weaDat.decAng.tNext,zon.fmuZon.TRad,zon.fmuZon.QLat_flow,zon.fmuZon.QPeo_flow,zon.fmuZon.yEP[1],zon.fmuZon.yEP[2],zon.fmuZon.yEP[3],zon.fmuZon.yEP[4],zon.fmuZon.yEP[5],zon.fmuZon.tNext,zon.fmuZon.tLast,zon.fmuZon.dtLast,zon.fmuZon.mInlet_flow,zon.fmuZon.TAveInlet,zon.fmuZon.TRooLast,zon.fmuZon.QConLast_flow,livFlo.yEP[1],livFlo.yEP[2],livFlo.tNext,livFlo.tLast,livFlo.dtLast,livFlo.TLast,livFlo.QLast_flow,conHea.hysHea.y,heaPum.com.isOn,heaPum.temPro.hysHig.y,heaPum.temPro.hysLow.y,heaPum.temPro.on.y,heaPum.temPro.hysdTConEva.y,borHol.borHol[1].TBouCon.QAve_flow,borHol.borHol[1].TBouCon.port.T,borHol.borHol[1].TBouCon.UOld,borHol.borHol[1].TBouCon.iSam,borHol.borHol[2].TBouCon.QAve_flow,borHol.borHol[2].TBouCon.port.T,borHol.borHol[2].TBouCon.UOld,borHol.borHol[2].TBouCon.iSam,borHol.borHol[3].TBouCon.QAve_flow,borHol.borHol[3].TBouCon.port.T,borHol.borHol[3].TBouCon.UOld,borHol.borHol[3].TBouCon.iSam,borHol.borHol[4].TBouCon.QAve_flow,borHol.borHol[4].TBouCon.port.T,borHol.borHol[4].TBouCon.UOld,borHol.borHol[4].TBouCon.iSam,borHol.borHol[5].TBouCon.QAve_flow,borHol.borHol[5].TBouCon.port.T,borHol.borHol[5].TBouCon.UOld,borHol.borHol[5].TBouCon.iSam,borHol.borHol[6].TBouCon.QAve_flow,borHol.borHol[6].TBouCon.port.T,borHol.borHol[6].TBouCon.UOld,borHol.borHol[6].TBouCon.iSam,borHol.borHol[7].TBouCon.QAve_flow,borHol.borHol[7].TBouCon.port.T,borHol.borHol[7].TBouCon.UOld,borHol.borHol[7].TBouCon.iSam,borHol.borHol[8].TBouCon.QAve_flow,borHol.borHol[8].TBouCon.port.T,borHol.borHol[8].TBouCon.UOld,borHol.borHol[8].TBouCon.iSam,borHol.borHol[9].TBouCon.QAve_flow,borHol.borHol[9].TBouCon.port.T,borHol.borHol[9].TBouCon.UOld,borHol.borHol[9].TBouCon.iSam,borHol.borHol[10].TBouCon.QAve_flow,borHol.borHol[10].TBouCon.port.T,borHol.borHol[10].TBouCon.UOld,borHol.borHol[10].TBouCon.iSam,ava.y)
 * Number of discrete states: 37 (zon.fmuZon.tNext,livFlo.tNext,zon.fmuZon.tLast,livFlo.tLast,borHol.borHol[1].TBouCon.iSam,borHol.borHol[1].TBouCon.UOld,borHol.borHol[2].TBouCon.iSam,borHol.borHol[2].TBouCon.UOld,borHol.borHol[3].TBouCon.iSam,borHol.borHol[3].TBouCon.UOld,borHol.borHol[4].TBouCon.iSam,borHol.borHol[4].TBouCon.UOld,borHol.borHol[5].TBouCon.iSam,borHol.borHol[5].TBouCon.UOld,borHol.borHol[6].TBouCon.iSam,borHol.borHol[6].TBouCon.UOld,borHol.borHol[7].TBouCon.iSam,borHol.borHol[7].TBouCon.UOld,borHol.borHol[8].TBouCon.iSam,borHol.borHol[8].TBouCon.UOld,borHol.borHol[9].TBouCon.iSam,borHol.borHol[9].TBouCon.UOld,borHol.borHol[10].TBouCon.iSam,borHol.borHol[10].TBouCon.UOld,heaPum.temPro.hysLow.y,heaPum.temPro.hysHig.y,heaPum.temPro.hysdTConEva.y,conHea.hysHea.y,heaPum.com.isOn,building.weaDat.conTimMin.tNext,building.weaDat.decAng.tNext,building.weaDat.eqnTim.tNext,building.weaDat.conTim.tNext,building.weaDat.locTim.tNext,zon.fmuZon.TAveInlet,zon.fmuZon.mInlet_flow,zon.fmuZon.QGaiRad_flow)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1045):
 * Single equations (assignments): 941
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 5
 * When equations: 63
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 35
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 32 systems
   {(1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (1,1,100.0%), (1,2,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(2,19), (1,7), (2,9)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.06968/5.714, allocations: 34.66 MB / 3.052 GB, free: 361.6 MB / 1.904 GB
Notification: Performance of simCode: created initialization part: time 0.08694/5.801, allocations: 52.66 MB / 3.104 GB, free: 307.9 MB / 1.904 GB
Notification: Performance of simCode: created event and clocks part: time 1.471e-05/5.801, allocations: 10.66 kB / 3.104 GB, free: 307.9 MB / 1.904 GB
Notification: Performance of simCode: created simulation system equations: time 0.01969/5.821, allocations: 12.62 MB / 3.116 GB, free: 294.8 MB / 1.904 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05199/5.873, allocations: 10.73 MB / 3.127 GB, free: 284.4 MB / 1.904 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4562/6.329, allocations: 251.1 MB / 3.372 GB, free: 29.64 MB / 1.904 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02345/6.352, allocations: 15.85 MB / 3.387 GB, free: 13.74 MB / 1.904 GB
Notification: Performance of simCode: alias equations: time 0.5759/6.928, allocations: 15.92 MB / 3.403 GB, free: 0.7383 GB / 1.904 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02448/6.953, allocations: 11.81 MB / 3.414 GB, free: 0.7383 GB / 1.904 GB
Notification: Performance of SimCode: time 1.232e-06/6.953, allocations: 1.203 kB / 3.414 GB, free: 0.7383 GB / 1.904 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.9056/7.858, allocations: 0.7125 GB / 4.127 GB, free: 172 MB / 1.904 GB
Notification: Performance of buildModelFMU: Generate platform static: time 92.69/100.6, allocations: 13.53 kB / 4.127 GB, free: 172 MB / 1.904 GB
"
[Timeout remaining time 199]
(rm -f Buildings_10_Buildings.ThermalZones.EnergyPlus_9_6_0.Examples.SingleFamilyHouse.HeatPumpRadiantHeatingGroundHeatTransfer.pipe ; mkfifo Buildings_10_Buildings.ThermalZones.EnergyPlus_9_6_0.Examples.SingleFamilyHouse.HeatPumpRadiantHeatingGroundHeatTransfer.pipe ; head -c 1048576 < Buildings_10_Buildings.ThermalZones.EnergyPlus_9_6_0.Examples.SingleFamilyHouse.HeatPumpRadiantHeatingGroundHeatTransfer.pipe >> ../files/Buildings_10_Buildings.ThermalZones.EnergyPlus_9_6_0.Examples.SingleFamilyHouse.HeatPumpRadiantHeatingGroundHeatTransfer.sim & python3 -m fmpy simulate  --output-file Buildings_10_Buildings.ThermalZones.EnergyPlus_9_6_0.Examples.SingleFamilyHouse.HeatPumpRadiantHeatingGroundHeatTransfer_res.csv --start-time 0 --stop-time 172800 --timeout 400 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 69.12 Buildings_10_Buildings_ThermalZones_EnergyPlus_9_6_0_Examples_SingleFamilyHouse_HeatPumpRadiantHeatingGroundHeatTransfer.fmu > Buildings_10_Buildings.ThermalZones.EnergyPlus_9_6_0.Examples.SingleFamilyHouse.HeatPumpRadiantHeatingGroundHeatTransfer.pipe 2>&1) [Timeout 420.0]
[Calling os._exit(0), Time elapsed: 106.53488837599434]