Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001449/0.001449, allocations: 108.3 kB / 19.7 MB, free: 1.918 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001584/0.001584, allocations: 215 kB / 22.99 MB, free: 4.977 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.564/1.564, allocations: 230.6 MB / 256.8 MB, free: 7.793 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo): time 1.102/1.102, allocations: 149.9 MB / 463 MB, free: 10.34 MB / 366.1 MB
"
[Timeout remaining time 178]
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling")
translateModel(IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling") [Timeout 660]
"Notification: IBPSA requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002147/0.002147, allocations: 70.14 kB / 0.6415 GB, free: 9.613 MB / 478.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2015/0.2036, allocations: 89.17 MB / 0.7286 GB, free: 0.5156 MB / 0.545 GB
Notification: Performance of NFInst.instantiate(IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling): time 0.01833/0.222, allocations: 12.99 MB / 0.7413 GB, free: 3.461 MB / 0.5606 GB
Notification: Performance of NFInst.instExpressions: time 0.6249/0.8469, allocations: 135.9 MB / 0.874 GB, free: 32 kB / 0.6387 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00413/0.8511, allocations: 67.67 kB / 0.8741 GB, free: 15.96 MB / 0.6544 GB
Notification: Performance of NFTyping.typeComponents: time 0.003608/0.8547, allocations: 0.6207 MB / 0.8747 GB, free: 15.34 MB / 0.6544 GB
Notification: Performance of NFTyping.typeBindings: time 0.008046/0.8627, allocations: 1.482 MB / 0.8761 GB, free: 13.87 MB / 0.6544 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007324/0.87, allocations: 2.289 MB / 0.8784 GB, free: 11.59 MB / 0.6544 GB
Notification: Performance of NFFlatten.flatten: time 0.01764/0.8877, allocations: 12.45 MB / 0.8905 GB, free: 15.12 MB / 0.67 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.007763/0.8954, allocations: 4.315 MB / 0.8947 GB, free: 10.69 MB / 0.67 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.008403/0.9038, allocations: 5.654 MB / 0.9003 GB, free: 5.023 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01378/0.9176, allocations: 6.374 MB / 0.9065 GB, free: 14.63 MB / 0.6856 GB
Notification: Performance of NFPackage.collectConstants: time 0.006901/0.9245, allocations: 1.898 MB / 0.9083 GB, free: 12.73 MB / 0.6856 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.009546/0.9341, allocations: 2.308 MB / 0.9106 GB, free: 10.42 MB / 0.6856 GB
Notification: Performance of NFScalarize.scalarize: time 0.008401/0.9425, allocations: 3.418 MB / 0.9139 GB, free: 6.996 MB / 0.6856 GB
Notification: Performance of NFVerifyModel.verify: time 0.01426/0.9567, allocations: 4.99 MB / 0.9188 GB, free: 1.988 MB / 0.6856 GB
Notification: Performance of NFConvertDAE.convert: time 0.03335/0.9901, allocations: 20.64 MB / 0.939 GB, free: 13.29 MB / 0.7169 GB
Notification: Performance of FrontEnd - DAE generated: time 1.035e-05/0.9901, allocations: 0 / 0.939 GB, free: 13.29 MB / 0.7169 GB
Notification: Performance of FrontEnd: time 2.725e-06/0.9901, allocations: 2.344 kB / 0.939 GB, free: 13.29 MB / 0.7169 GB
Notification: Performance of Transformations before backend: time 0.0008475/0.9909, allocations: 0 / 0.939 GB, free: 13.29 MB / 0.7169 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2322
 * Number of variables: 2322
Notification: Performance of Generate backend data structure: time 0.06314/1.054, allocations: 11.18 MB / 0.9499 GB, free: 1.988 MB / 0.7169 GB
Notification: Performance of prepare preOptimizeDAE: time 8.824e-05/1.054, allocations: 8.031 kB / 0.9499 GB, free: 1.98 MB / 0.7169 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1889/1.243, allocations: 36.36 MB / 0.9854 GB, free: 13.57 MB / 0.7637 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02061/1.264, allocations: 6.861 MB / 0.9921 GB, free: 6.645 MB / 0.7637 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001019/1.265, allocations: 0.6701 MB / 0.9927 GB, free: 5.973 MB / 0.7637 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.006232/1.271, allocations: 0.8827 MB / 0.9936 GB, free: 5.09 MB / 0.7637 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.1092/1.38, allocations: 32.84 MB / 1.026 GB, free: 4.055 MB / 0.795 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002855/1.38, allocations: 7.938 kB / 1.026 GB, free: 4.047 MB / 0.795 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004218/1.385, allocations: 371.2 kB / 1.026 GB, free: 3.688 MB / 0.795 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002198/1.385, allocations: 216 kB / 1.026 GB, free: 3.477 MB / 0.795 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1684/1.553, allocations: 50.33 MB / 1.075 GB, free: 1.082 MB / 0.8419 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.9799/2.533, allocations: 64.9 MB / 1.139 GB, free: 260 MB / 0.8575 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.08228/2.615, allocations: 24.98 MB / 1.163 GB, free: 249.5 MB / 0.8575 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.06014/2.675, allocations: 18.51 MB / 1.181 GB, free: 233.5 MB / 0.8575 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001232/2.677, allocations: 173.2 kB / 1.181 GB, free: 233.3 MB / 0.8575 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.06535/2.742, allocations: 20.35 MB / 1.201 GB, free: 212.8 MB / 0.8575 GB
Notification: Performance of pre-optimization done (n=710): time 1.611e-05/2.742, allocations: 0 / 1.201 GB, free: 212.8 MB / 0.8575 GB
Notification: Performance of matching and sorting (n=710): time 0.1886/2.931, allocations: 53.27 MB / 1.253 GB, free: 159.5 MB / 0.8575 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002363/2.931, allocations: 316.8 kB / 1.254 GB, free: 159.1 MB / 0.8575 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007122/2.938, allocations: 3.433 MB / 1.257 GB, free: 155.7 MB / 0.8575 GB
Notification: Performance of collectPreVariables (initialization): time 0.004012/2.942, allocations: 210.7 kB / 1.257 GB, free: 155.5 MB / 0.8575 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003245/2.945, allocations: 3.119 MB / 1.26 GB, free: 152.8 MB / 0.8575 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005479/2.951, allocations: 2.399 MB / 1.263 GB, free: 150.7 MB / 0.8575 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01104/2.962, allocations: 1.49 MB / 1.264 GB, free: 149.2 MB / 0.8575 GB
Notification: Performance of setup shared object (initialization): time 4.686e-05/2.962, allocations: 305.1 kB / 1.264 GB, free: 148.9 MB / 0.8575 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.05772/3.02, allocations: 18.08 MB / 1.282 GB, free: 130.8 MB / 0.8575 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.05943/3.079, allocations: 18.81 MB / 1.3 GB, free: 111.9 MB / 0.8575 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1086/3.188, allocations: 31.74 MB / 1.331 GB, free: 80.04 MB / 0.8575 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.471e-05/3.188, allocations: 4 kB / 1.331 GB, free: 80.03 MB / 0.8575 GB
Notification: Performance of matching and sorting (n=847) (initialization): time 0.1279/3.316, allocations: 35.81 MB / 1.366 GB, free: 44.15 MB / 0.8575 GB
Notification: Performance of prepare postOptimizeDAE: time 4.623e-05/3.316, allocations: 12.03 kB / 1.366 GB, free: 44.14 MB / 0.8575 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.247e-05/3.316, allocations: 9.031 kB / 1.366 GB, free: 44.13 MB / 0.8575 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00148/3.317, allocations: 361.4 kB / 1.367 GB, free: 43.77 MB / 0.8575 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.03399/3.351, allocations: 6.191 MB / 1.373 GB, free: 37.57 MB / 0.8575 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006268/3.357, allocations: 4.791 MB / 1.377 GB, free: 32.6 MB / 0.8575 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.031/3.388, allocations: 5.321 MB / 1.383 GB, free: 27.4 MB / 0.8575 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003825/3.392, allocations: 355.6 kB / 1.383 GB, free: 27.05 MB / 0.8575 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 24
 * Number of states: 0 ()
 * Number of discrete variables: 119 (weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,zon5R1C.opa.HDifTilRof.incAng.decAng.k,$PRE.zon5R1C.opa.HDifTilRof.incAng.decAng.k,zon5R1C.opa.HDifTilRof.incAng.decAng.tNext,$PRE.zon5R1C.opa.HDifTilRof.incAng.decAng.tNext,zon5R1C.opa.HDirTilRoo.incAng.decAng.k,$PRE.zon5R1C.opa.HDirTilRoo.incAng.decAng.k,zon5R1C.opa.HDirTilRoo.incAng.decAng.tNext,$PRE.zon5R1C.opa.HDirTilRoo.incAng.decAng.tNext,zon5R1C.opa.HDifTil[4].incAng.decAng.k,$PRE.zon5R1C.opa.HDifTil[4].incAng.decAng.k,zon5R1C.opa.HDifTil[4].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDifTil[4].incAng.decAng.tNext,zon5R1C.opa.HDifTil[3].incAng.decAng.k,$PRE.zon5R1C.opa.HDifTil[3].incAng.decAng.k,zon5R1C.opa.HDifTil[3].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDifTil[3].incAng.decAng.tNext,zon5R1C.opa.HDifTil[2].incAng.decAng.k,$PRE.zon5R1C.opa.HDifTil[2].incAng.decAng.k,zon5R1C.opa.HDifTil[2].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDifTil[2].incAng.decAng.tNext,zon5R1C.opa.HDifTil[1].incAng.decAng.k,$PRE.zon5R1C.opa.HDifTil[1].incAng.decAng.k,zon5R1C.opa.HDifTil[1].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDifTil[1].incAng.decAng.tNext,zon5R1C.opa.HDirTil[4].incAng.decAng.k,$PRE.zon5R1C.opa.HDirTil[4].incAng.decAng.k,zon5R1C.opa.HDirTil[4].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDirTil[4].incAng.decAng.tNext,zon5R1C.opa.HDirTil[3].incAng.decAng.k,$PRE.zon5R1C.opa.HDirTil[3].incAng.decAng.k,zon5R1C.opa.HDirTil[3].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDirTil[3].incAng.decAng.tNext,zon5R1C.opa.HDirTil[2].incAng.decAng.k,$PRE.zon5R1C.opa.HDirTil[2].incAng.decAng.k,zon5R1C.opa.HDirTil[2].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDirTil[2].incAng.decAng.tNext,zon5R1C.opa.HDirTil[1].incAng.decAng.k,$PRE.zon5R1C.opa.HDirTil[1].incAng.decAng.k,zon5R1C.opa.HDirTil[1].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDirTil[1].incAng.decAng.tNext,zon5R1C.win.HDifTil[4].incAng.decAng.k,$PRE.zon5R1C.win.HDifTil[4].incAng.decAng.k,zon5R1C.win.HDifTil[4].incAng.decAng.tNext,$PRE.zon5R1C.win.HDifTil[4].incAng.decAng.tNext,zon5R1C.win.HDifTil[3].incAng.decAng.k,$PRE.zon5R1C.win.HDifTil[3].incAng.decAng.k,zon5R1C.win.HDifTil[3].incAng.decAng.tNext,$PRE.zon5R1C.win.HDifTil[3].incAng.decAng.tNext,zon5R1C.win.HDifTil[2].incAng.decAng.k,$PRE.zon5R1C.win.HDifTil[2].incAng.decAng.k,zon5R1C.win.HDifTil[2].incAng.decAng.tNext,$PRE.zon5R1C.win.HDifTil[2].incAng.decAng.tNext,zon5R1C.win.HDifTil[1].incAng.decAng.k,$PRE.zon5R1C.win.HDifTil[1].incAng.decAng.k,zon5R1C.win.HDifTil[1].incAng.decAng.tNext,$PRE.zon5R1C.win.HDifTil[1].incAng.decAng.tNext,zon5R1C.win.HDirTil[4].incAng.decAng.k,$PRE.zon5R1C.win.HDirTil[4].incAng.decAng.k,zon5R1C.win.HDirTil[4].incAng.decAng.tNext,$PRE.zon5R1C.win.HDirTil[4].incAng.decAng.tNext,zon5R1C.win.HDirTil[3].incAng.decAng.k,$PRE.zon5R1C.win.HDirTil[3].incAng.decAng.k,zon5R1C.win.HDirTil[3].incAng.decAng.tNext,$PRE.zon5R1C.win.HDirTil[3].incAng.decAng.tNext,zon5R1C.win.HDirTil[2].incAng.decAng.k,$PRE.zon5R1C.win.HDirTil[2].incAng.decAng.k,zon5R1C.win.HDirTil[2].incAng.decAng.tNext,$PRE.zon5R1C.win.HDirTil[2].incAng.decAng.tNext,zon5R1C.win.HDirTil[1].incAng.decAng.k,$PRE.zon5R1C.win.HDirTil[1].incAng.decAng.k,zon5R1C.win.HDirTil[1].incAng.decAng.tNext,$PRE.zon5R1C.win.HDirTil[1].incAng.decAng.tNext,weaDat.decAng.k,$PRE.weaDat.decAng.k,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.k,$PRE.weaDat.eqnTim.k,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.k,$PRE.weaDat.conTim.k,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.k,$PRE.weaDat.conTimMin.k,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.k,$PRE.weaDat.locTim.k,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,conCooPID.I.trigger_internal,conHeaPID.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (819):
 * Single equations (assignments): 817
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(2,25), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.01204/3.404, allocations: 2.973 MB / 1.386 GB, free: 24.07 MB / 0.8575 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00604/3.41, allocations: 488.9 kB / 1.386 GB, free: 23.59 MB / 0.8575 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.147/3.557, allocations: 37.77 MB / 1.423 GB, free: 1.781 MB / 0.8732 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001159/3.557, allocations: 72 kB / 1.423 GB, free: 1.711 MB / 0.8732 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.98e-05/3.557, allocations: 0 / 1.423 GB, free: 1.711 MB / 0.8732 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0002738/3.558, allocations: 35.86 kB / 1.423 GB, free: 1.676 MB / 0.8732 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.6557/4.213, allocations: 60.24 MB / 1.482 GB, free: 280.5 MB / 0.8732 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001122/4.214, allocations: 0 / 1.482 GB, free: 280.5 MB / 0.8732 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.03251/4.246, allocations: 5.978 MB / 1.488 GB, free: 276.8 MB / 0.8732 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001324/4.247, allocations: 339.2 kB / 1.488 GB, free: 276.4 MB / 0.8732 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.003304/4.251, allocations: 260.7 kB / 1.489 GB, free: 276.2 MB / 0.8732 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005591/4.256, allocations: 4.804 MB / 1.493 GB, free: 271.3 MB / 0.8732 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.823e-06/4.256, allocations: 0 / 1.493 GB, free: 271.3 MB / 0.8732 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1841/4.44, allocations: 58.07 MB / 1.55 GB, free: 213.4 MB / 0.8732 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01101/4.451, allocations: 3.23 MB / 1.553 GB, free: 210.2 MB / 0.8732 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005286/4.457, allocations: 239.6 kB / 1.553 GB, free: 210 MB / 0.8732 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.03014/4.487, allocations: 4.963 MB / 1.558 GB, free: 205 MB / 0.8732 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00285/4.49, allocations: 0.5321 MB / 1.559 GB, free: 204.5 MB / 0.8732 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.003771/4.493, allocations: 311.6 kB / 1.559 GB, free: 204.2 MB / 0.8732 GB
Notification: Performance of sorting global known variables: time 0.006073/4.499, allocations: 2.635 MB / 1.562 GB, free: 201.6 MB / 0.8732 GB
Notification: Performance of sort global known variables: time 1.1e-07/4.499, allocations: 0 / 1.562 GB, free: 201.6 MB / 0.8732 GB
Notification: Performance of remove unused functions: time 0.01588/4.515, allocations: 2.875 MB / 1.564 GB, free: 198.9 MB / 0.8732 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 3 (zon5R1C.capMas.T,conHeaPID.I.y,conCooPID.I.y)
 * Number of discrete variables: 69 ($whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,weaDat.locTim.tNext,weaDat.locTim.k,weaDat.conTimMin.tNext,weaDat.conTimMin.k,weaDat.conTim.tNext,weaDat.conTim.k,weaDat.eqnTim.tNext,weaDat.eqnTim.k,weaDat.decAng.tNext,weaDat.decAng.k,zon5R1C.win.HDirTil[1].incAng.decAng.tNext,zon5R1C.win.HDirTil[1].incAng.decAng.k,zon5R1C.win.HDirTil[2].incAng.decAng.tNext,zon5R1C.win.HDirTil[2].incAng.decAng.k,zon5R1C.win.HDirTil[3].incAng.decAng.tNext,zon5R1C.win.HDirTil[3].incAng.decAng.k,zon5R1C.win.HDirTil[4].incAng.decAng.tNext,zon5R1C.win.HDirTil[4].incAng.decAng.k,zon5R1C.win.HDifTil[1].incAng.decAng.tNext,zon5R1C.win.HDifTil[1].incAng.decAng.k,zon5R1C.win.HDifTil[2].incAng.decAng.tNext,zon5R1C.win.HDifTil[2].incAng.decAng.k,zon5R1C.win.HDifTil[3].incAng.decAng.tNext,zon5R1C.win.HDifTil[3].incAng.decAng.k,zon5R1C.win.HDifTil[4].incAng.decAng.tNext,zon5R1C.win.HDifTil[4].incAng.decAng.k,zon5R1C.opa.HDirTil[1].incAng.decAng.tNext,zon5R1C.opa.HDirTil[1].incAng.decAng.k,zon5R1C.opa.HDirTil[2].incAng.decAng.tNext,zon5R1C.opa.HDirTil[2].incAng.decAng.k,zon5R1C.opa.HDirTil[3].incAng.decAng.tNext,zon5R1C.opa.HDirTil[3].incAng.decAng.k,zon5R1C.opa.HDirTil[4].incAng.decAng.tNext,zon5R1C.opa.HDirTil[4].incAng.decAng.k,zon5R1C.opa.HDifTil[1].incAng.decAng.tNext,zon5R1C.opa.HDifTil[1].incAng.decAng.k,zon5R1C.opa.HDifTil[2].incAng.decAng.tNext,zon5R1C.opa.HDifTil[2].incAng.decAng.k,zon5R1C.opa.HDifTil[3].incAng.decAng.tNext,zon5R1C.opa.HDifTil[3].incAng.decAng.k,zon5R1C.opa.HDifTil[4].incAng.decAng.tNext,zon5R1C.opa.HDifTil[4].incAng.decAng.k,zon5R1C.opa.HDirTilRoo.incAng.decAng.tNext,zon5R1C.opa.HDirTilRoo.incAng.decAng.k,zon5R1C.opa.HDifTilRof.incAng.decAng.tNext,zon5R1C.opa.HDifTilRof.incAng.decAng.k)
 * Number of discrete states: 46 (zon5R1C.opa.HDifTil[2].incAng.decAng.tNext,zon5R1C.opa.HDifTil[3].incAng.decAng.tNext,zon5R1C.opa.HDifTil[4].incAng.decAng.tNext,zon5R1C.opa.HDirTil[1].incAng.decAng.tNext,zon5R1C.opa.HDirTil[2].incAng.decAng.tNext,zon5R1C.opa.HDirTil[3].incAng.decAng.tNext,zon5R1C.opa.HDirTil[4].incAng.decAng.tNext,zon5R1C.opa.HDirTilRoo.incAng.decAng.tNext,zon5R1C.win.HDifTil[1].incAng.decAng.tNext,zon5R1C.win.HDifTil[2].incAng.decAng.tNext,zon5R1C.win.HDifTil[3].incAng.decAng.tNext,zon5R1C.win.HDifTil[4].incAng.decAng.tNext,zon5R1C.win.HDirTil[1].incAng.decAng.tNext,zon5R1C.win.HDirTil[2].incAng.decAng.tNext,zon5R1C.win.HDirTil[3].incAng.decAng.tNext,zon5R1C.win.HDirTil[4].incAng.decAng.tNext,weaDat.locTim.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,zon5R1C.opa.HDifTil[1].incAng.decAng.tNext,zon5R1C.opa.HDifTilRof.incAng.decAng.tNext,weaDat.conTimMin.tNext,zon5R1C.opa.HDifTilRof.incAng.decAng.k,zon5R1C.opa.HDirTilRoo.incAng.decAng.k,zon5R1C.opa.HDifTil[4].incAng.decAng.k,zon5R1C.opa.HDifTil[3].incAng.decAng.k,zon5R1C.opa.HDifTil[2].incAng.decAng.k,zon5R1C.opa.HDifTil[1].incAng.decAng.k,zon5R1C.opa.HDirTil[4].incAng.decAng.k,zon5R1C.opa.HDirTil[3].incAng.decAng.k,zon5R1C.opa.HDirTil[2].incAng.decAng.k,zon5R1C.opa.HDirTil[1].incAng.decAng.k,zon5R1C.win.HDifTil[4].incAng.decAng.k,zon5R1C.win.HDifTil[3].incAng.decAng.k,zon5R1C.win.HDifTil[2].incAng.decAng.k,zon5R1C.win.HDifTil[1].incAng.decAng.k,zon5R1C.win.HDirTil[4].incAng.decAng.k,zon5R1C.win.HDirTil[3].incAng.decAng.k,zon5R1C.win.HDirTil[2].incAng.decAng.k,zon5R1C.win.HDirTil[1].incAng.decAng.k,weaDat.decAng.k,weaDat.eqnTim.k,weaDat.conTim.k,weaDat.conTimMin.k,weaDat.locTim.k)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (732):
 * Single equations (assignments): 684
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 46
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(2,25), (1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.006702/4.522, allocations: 0.9459 MB / 1.565 GB, free: 198.3 MB / 0.8732 GB
Notification: Performance of simCode: created initialization part: time 0.1217/4.644, allocations: 37.31 MB / 1.602 GB, free: 160.9 MB / 0.8732 GB
Notification: Performance of simCode: created event and clocks part: time 8.335e-06/4.644, allocations: 3.938 kB / 1.602 GB, free: 160.9 MB / 0.8732 GB
Notification: Performance of simCode: created simulation system equations: time 0.06193/4.706, allocations: 18.7 MB / 1.62 GB, free: 142.2 MB / 0.8732 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01351/4.719, allocations: 0.7548 MB / 1.621 GB, free: 141.5 MB / 0.8732 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.09272/4.812, allocations: 32.08 MB / 1.652 GB, free: 109.3 MB / 0.8732 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.006942/4.819, allocations: 5.208 MB / 1.657 GB, free: 104.1 MB / 0.8732 GB
Notification: Performance of simCode: alias equations: time 0.02155/4.84, allocations: 3.615 MB / 1.661 GB, free: 100.5 MB / 0.8732 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01092/4.851, allocations: 0.7291 MB / 1.661 GB, free: 99.73 MB / 0.8732 GB
Notification: Performance of SimCode: time 1.323e-06/4.851, allocations: 0 / 1.661 GB, free: 99.73 MB / 0.8732 GB
Notification: Performance of Templates: time 0.6987/5.55, allocations: 152.5 MB / 1.81 GB, free: 273.7 MB / 0.8732 GB
"
[Timeout remaining time 654]
make -j1 -f IBPSA_latest_IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling.makefile [Timeout 660]
(rm -f IBPSA_latest_IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling.pipe ; mkfifo IBPSA_latest_IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling.pipe >> ../files/IBPSA_latest_IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling.sim & ./IBPSA_latest_IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.ThermalZones.ISO13790.Examples.HeatingCooling.pipe 2>&1) [Timeout 480]
[Calling sys.exit(0), Time elapsed: 17.45490612089634]
Failed to read output from testmodel.py, exit status != 0:
5.561126627027988 5.571704528 4.578802038
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f6867d5efe0>