Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency.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/IDEAS 3.0.0/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.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(IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency")
translateModel(IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0007452/0.0007451, allocations: 91.84 kB / 15.36 MB, free: 0.7383 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.004904/0.004904, allocations: 170.8 kB / 16.26 MB, free: 6.676 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.395/1.395, allocations: 223.2 MB / 240.3 MB, free: 5.336 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.8087/0.8087, allocations: 132.3 MB / 423.8 MB, free: 1.957 MB / 350.1 MB
Warning: Ignoring unknown experiment annotation option: __Dymola_NumberOfIntervals = 5000
Warning: Ignoring unknown experiment annotation option: __Dymola_Algorithm = "Lsodar"
Warning: Ignoring unknown experiment annotation option: __Dymola_NumberOfIntervals = 5000
Warning: Ignoring unknown experiment annotation option: __Dymola_Algorithm = "Lsodar"
Notification: Performance of FrontEnd - loaded program: time 0.000373/0.0003733, allocations: 13.33 kB / 0.504 GB, free: 3.895 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5091/0.5095, allocations: 81.57 MB / 0.5837 GB, free: 4.043 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency): time 0.9972/1.507, allocations: 477.4 MB / 1.05 GB, free: 9.223 MB / 0.7169 GB
Notification: Performance of NFInst.instExpressions: time 0.7805/2.287, allocations: 164.8 MB / 1.211 GB, free: 14.43 MB / 0.7794 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.05818/2.346, allocations: 0.8748 MB / 1.212 GB, free: 14.43 MB / 0.7794 GB
Notification: Performance of NFTyping.typeComponents: time 0.01264/2.358, allocations: 3.827 MB / 1.215 GB, free: 13.59 MB / 0.7794 GB
Notification: Performance of NFTyping.typeBindings: time 0.02294/2.381, allocations: 5.647 MB / 1.221 GB, free: 11.21 MB / 0.7794 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01688/2.398, allocations: 4.266 MB / 1.225 GB, free: 8.285 MB / 0.7794 GB
Notification: Performance of NFFlatten.flatten: time 0.032/2.43, allocations: 21.16 MB / 1.246 GB, free: 15.67 MB / 0.795 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02849/2.459, allocations: 15.21 MB / 1.261 GB, free: 6.969 MB / 0.795 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01786/2.477, allocations: 6.481 MB / 1.267 GB, free: 1.609 MB / 0.795 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01476/2.491, allocations: 6.444 MB / 1.273 GB, free: 11.36 MB / 0.8106 GB
Notification: Performance of NFPackage.collectConstants: time 0.004202/2.496, allocations: 464 kB / 1.274 GB, free: 10.91 MB / 0.8106 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01367/2.509, allocations: 3.473 MB / 1.277 GB, free: 7.703 MB / 0.8106 GB
Notification: Performance of NFScalarize.scalarize: time 0.005852/2.515, allocations: 2.84 MB / 1.28 GB, free: 4.891 MB / 0.8106 GB
Notification: Performance of NFVerifyModel.verify: time 0.01589/2.531, allocations: 6.859 MB / 1.286 GB, free: 14.03 MB / 0.8262 GB
Notification: Performance of NFConvertDAE.convert: time 0.03454/2.566, allocations: 24.96 MB / 1.311 GB, free: 5.652 MB / 0.8419 GB
Notification: Performance of FrontEnd - DAE generated: time 7.434e-06/2.566, allocations: 0 / 1.311 GB, free: 5.652 MB / 0.8419 GB
Notification: Performance of FrontEnd: time 8.085e-06/2.566, allocations: 4 kB / 1.311 GB, free: 5.648 MB / 0.8419 GB
Notification: Performance of Transformations before backend: time 0.001263/2.567, allocations: 0 / 1.311 GB, free: 5.648 MB / 0.8419 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2905
 * Number of variables: 2905
Notification: Performance of Generate backend data structure: time 0.03471/2.602, allocations: 13.98 MB / 1.325 GB, free: 7.641 MB / 0.8575 GB
Notification: Performance of prepare preOptimizeDAE: time 4.772e-05/2.602, allocations: 8.031 kB / 1.325 GB, free: 7.633 MB / 0.8575 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01792/2.62, allocations: 3.035 MB / 1.327 GB, free: 4.578 MB / 0.8575 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03692/2.657, allocations: 14.34 MB / 1.341 GB, free: 6.348 MB / 0.8731 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001225/2.658, allocations: 1.021 MB / 1.342 GB, free: 5.289 MB / 0.8731 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003549/2.662, allocations: 1.095 MB / 1.344 GB, free: 4.195 MB / 0.8731 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03905/2.701, allocations: 13.85 MB / 1.357 GB, free: 6.094 MB / 0.8887 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0005596/2.701, allocations: 19.8 kB / 1.357 GB, free: 6.074 MB / 0.8887 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003785/2.705, allocations: 469.5 kB / 1.358 GB, free: 5.617 MB / 0.8887 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003999/2.706, allocations: 370.3 kB / 1.358 GB, free: 5.254 MB / 0.8887 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03064/2.736, allocations: 11.79 MB / 1.369 GB, free: 9.457 MB / 0.9044 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.1008/2.837, allocations: 61.83 MB / 1.43 GB, free: 6.953 MB / 0.9669 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01741/2.855, allocations: 8.026 MB / 1.438 GB, free: 14.68 MB / 0.9825 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.007624/2.862, allocations: 3.307 MB / 1.441 GB, free: 11.34 MB / 0.9825 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002149/2.864, allocations: 1.861 MB / 1.443 GB, free: 9.121 MB / 0.9825 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.008811/2.873, allocations: 3.535 MB / 1.446 GB, free: 5.496 MB / 0.9825 GB
Notification: Performance of pre-optimization done (n=454): time 1.101e-05/2.873, allocations: 0 / 1.446 GB, free: 5.496 MB / 0.9825 GB
Notification: Performance of matching and sorting (n=454): time 0.7271/3.6, allocations: 11.65 MB / 1.458 GB, free: 0.5094 GB / 0.9825 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002384/3.601, allocations: 0.7675 MB / 1.458 GB, free: 0.5085 GB / 0.9825 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02521/3.626, allocations: 11.04 MB / 1.469 GB, free: 0.505 GB / 0.9825 GB
Notification: Performance of collectPreVariables (initialization): time 0.001512/3.627, allocations: 113.7 kB / 1.469 GB, free: 0.5049 GB / 0.9825 GB
Notification: Performance of collectInitialEqns (initialization): time 0.007632/3.635, allocations: 6.954 MB / 1.476 GB, free: 0.5009 GB / 0.9825 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002199/3.637, allocations: 1.579 MB / 1.477 GB, free: 0.4997 GB / 0.9825 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001131/3.638, allocations: 0.6229 MB / 1.478 GB, free: 0.4995 GB / 0.9825 GB
Notification: Performance of setup shared object (initialization): time 7.592e-05/3.638, allocations: 307.7 kB / 1.478 GB, free: 0.4992 GB / 0.9825 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007542/3.646, allocations: 3.465 MB / 1.482 GB, free: 0.498 GB / 0.9825 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.009213/3.655, allocations: 5.08 MB / 1.487 GB, free: 0.495 GB / 0.9825 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0154/3.671, allocations: 8.136 MB / 1.495 GB, free: 0.4906 GB / 0.9825 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.016e-05/3.671, allocations: 11.88 kB / 1.495 GB, free: 0.4906 GB / 0.9825 GB
Notification: Performance of matching and sorting (n=882) (initialization): time 0.02842/3.699, allocations: 10.97 MB / 1.505 GB, free: 497.5 MB / 0.9825 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001438/3.699, allocations: 30.89 kB / 1.505 GB, free: 497.5 MB / 0.9825 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001589/3.7, allocations: 40.31 kB / 1.505 GB, free: 497.5 MB / 0.9825 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004789/3.704, allocations: 1.321 MB / 1.507 GB, free: 496.9 MB / 0.9825 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00826/3.713, allocations: 1.58 MB / 1.508 GB, free: 496.5 MB / 0.9825 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01024/3.723, allocations: 9.368 MB / 1.517 GB, free: 488.9 MB / 0.9825 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01069/3.734, allocations: 1.2 MB / 1.519 GB, free: 488.2 MB / 0.9825 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001559/3.735, allocations: 321.8 kB / 1.519 GB, free: 488.1 MB / 0.9825 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 183
 * Number of states: 0 ()
 * Number of discrete variables: 28 (winNor.q50_zone.using_custom_q50,winEas.q50_zone.using_custom_q50,winSou.q50_zone.using_custom_q50,zone1.setq50.use_custom_n50s[3],zone1.setq50.use_custom_n50s[2],zone1.setq50.use_custom_n50s[1],zone1.setq50.allSurfacesCustom,zone1.radDistrLw.computeCarroll,sim.weaDat.conTim.canRepeatWeatherFile,sim.weaDat.conTimMin.canRepeatWeatherFile,sim.radSol[1].solAzi.outsidePolarCircle,sim.radSol[2].solAzi.outsidePolarCircle,sim.radSol[3].solAzi.outsidePolarCircle,sim.radSol[4].solAzi.outsidePolarCircle,sim.radSol[5].solAzi.outsidePolarCircle,sim.radSol[6].solAzi.outsidePolarCircle,zone1.setq50.use_custom_q50[3],zone1.setq50.use_custom_q50[2],zone1.setq50.use_custom_q50[1],winNor.setArea.use_custom_n50,winEas.setArea.use_custom_n50,winSou.setArea.use_custom_n50,sim.weaDat.conTim.tNext,$PRE.sim.weaDat.conTim.tNext,sim.weaDat.conTimMin.tNext,$PRE.sim.weaDat.conTimMin.tNext,$whenCondition1,$whenCondition2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (802):
 * Single equations (assignments): 796
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(3,17,100.0%), (2,14,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(3,38), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.01016/3.745, allocations: 4.279 MB / 1.523 GB, free: 485.5 MB / 0.9825 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003084/3.749, allocations: 1.063 MB / 1.524 GB, free: 485 MB / 0.9825 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02345/3.772, allocations: 8.218 MB / 1.532 GB, free: 476.8 MB / 0.9825 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.723e-05/3.772, allocations: 55.7 kB / 1.532 GB, free: 476.8 MB / 0.9825 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.679e-05/3.772, allocations: 11.94 kB / 1.532 GB, free: 476.7 MB / 0.9825 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01638/3.789, allocations: 6.079 MB / 1.538 GB, free: 470.6 MB / 0.9825 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 postOpt removeSimpleEquations (simulation): time 0.05521/3.844, allocations: 21.19 MB / 1.559 GB, free: 449.2 MB / 0.9825 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.299e-05/3.844, allocations: 8.875 kB / 1.559 GB, free: 449.2 MB / 0.9825 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.006963/3.851, allocations: 0.9088 MB / 1.56 GB, free: 448.3 MB / 0.9825 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003619/3.855, allocations: 0.8579 MB / 1.561 GB, free: 447.4 MB / 0.9825 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001024/3.856, allocations: 135.4 kB / 1.561 GB, free: 447.3 MB / 0.9825 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00985/3.866, allocations: 7.792 MB / 1.568 GB, free: 439.1 MB / 0.9825 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 9.207e-06/3.866, allocations: 13.05 kB / 1.568 GB, free: 439.1 MB / 0.9825 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.03837/3.904, allocations: 11.54 MB / 1.58 GB, free: 427.4 MB / 0.9825 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.007946/3.912, allocations: 1.884 MB / 1.581 GB, free: 425.4 MB / 0.9825 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003891/3.916, allocations: 99.98 kB / 1.582 GB, free: 425.3 MB / 0.9825 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.008287/3.924, allocations: 0.5232 MB / 1.582 GB, free: 424.8 MB / 0.9825 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001362/3.926, allocations: 319 kB / 1.582 GB, free: 424.5 MB / 0.9825 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001032/3.927, allocations: 167.9 kB / 1.583 GB, free: 424.3 MB / 0.9825 GB
Notification: Performance of sorting global known variables: time 0.01722/3.944, allocations: 7.544 MB / 1.59 GB, free: 416.9 MB / 0.9825 GB
Notification: Performance of sort global known variables: time 4.4e-07/3.944, allocations: 0 / 1.59 GB, free: 416.9 MB / 0.9825 GB
Notification: Performance of remove unused functions: time 0.01589/3.96, allocations: 3.095 MB / 1.593 GB, free: 413.8 MB / 0.9825 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 34
 * Number of states: 9 (winSou.heaCapGlaInt.T,winSou.heaCapGlaExt.T,zone1.airModel.vol.dynBal.U,zone1.airModel.vol.dynBal.m,zone1.airModel.vol.dynBal.mXi[1],winNor.layMul.monLay[1].monLayDyn.T[1],winNor.layMul.monLay[1].monLayDyn.T[2],winNor.layMul.monLay[3].monLayDyn.T[1],winNor.layMul.monLay[3].monLayDyn.T[2])
 * Number of discrete variables: 4 ($whenCondition2,$whenCondition1,sim.weaDat.conTimMin.tNext,sim.weaDat.conTim.tNext)
 * Number of discrete states: 2 (sim.weaDat.conTimMin.tNext,sim.weaDat.conTim.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (430):
 * Single equations (assignments): 424
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 2
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * 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,2,100.0%), (2,14,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(3,38), (1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.003944/3.964, allocations: 0.9863 MB / 1.594 GB, free: 413.2 MB / 0.9825 GB
Notification: Performance of simCode: created initialization part: time 0.01946/3.983, allocations: 8.139 MB / 1.602 GB, free: 405 MB / 0.9825 GB
Notification: Performance of simCode: created event and clocks part: time 2.203e-05/3.983, allocations: 4 kB / 1.602 GB, free: 405 MB / 0.9825 GB
Notification: Performance of simCode: created simulation system equations: time 0.009916/3.993, allocations: 3.716 MB / 1.605 GB, free: 401.2 MB / 0.9825 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.03315/4.026, allocations: 2.467 MB / 1.608 GB, free: 398.9 MB / 0.9825 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.05425/4.081, allocations: 32.06 MB / 1.639 GB, free: 366.7 MB / 0.9825 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01077/4.092, allocations: 8.09 MB / 1.647 GB, free: 358.6 MB / 0.9825 GB
Notification: Performance of simCode: alias equations: time 0.01148/4.103, allocations: 2.513 MB / 1.65 GB, free: 356.1 MB / 0.9825 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003013/4.106, allocations: 0.8038 MB / 1.65 GB, free: 355.2 MB / 0.9825 GB
Notification: Performance of SimCode: time 1.673e-06/4.106, allocations: 0 / 1.65 GB, free: 355.2 MB / 0.9825 GB
Notification: Performance of Templates: time 0.2208/4.327, allocations: 122.9 MB / 1.77 GB, free: 233.3 MB / 0.9825 GB
make -j1 -f IDEAS_IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency.makefile
(rm -f IDEAS_IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency.pipe ; mkfifo IDEAS_IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency.pipe ; head -c 1048576 < IDEAS_IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency.pipe >> ../files/IDEAS_IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency.sim & ./IDEAS_IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_IDEAS.Buildings.Components.Validations.CeilingOrientationConsistency.pipe 2>&1)