Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_8_Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE.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 3.2.3+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/package.mo", uses=false) Using package Buildings with version 8.1.4 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/package.mo) Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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(Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8_Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE") translateModel(Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8_Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001754/0.001754, allocations: 115.4 kB / 16.38 MB, free: 5.547 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.001848/0.001848, allocations: 186.3 kB / 17.31 MB, free: 5.188 MB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.292/1.292, allocations: 205.1 MB / 223.2 MB, free: 12.25 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/package.mo): time 1.771/1.771, allocations: 292.3 MB / 0.5496 GB, free: 17.38 MB / 462.1 MB Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed. Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed. Notification: Performance of FrontEnd - loaded program: time 0.001382/0.001382, allocations: 64.12 kB / 0.6729 GB, free: 5.871 MB / 0.545 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.2011/0.2025, allocations: 114.6 MB / 0.7848 GB, free: 3.191 MB / 0.6544 GB Notification: Performance of NFInst.instantiate(Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE): time 0.6496/0.8521, allocations: 311.1 MB / 1.089 GB, free: 2.52 MB / 0.8731 GB Notification: Performance of NFInst.instExpressions: time 0.05994/0.9121, allocations: 36.07 MB / 1.124 GB, free: 14.37 MB / 0.92 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.01243/0.9246, allocations: 270.6 kB / 1.124 GB, free: 14.1 MB / 0.92 GB Notification: Performance of NFTyping.typeComponents: time 0.008389/0.9331, allocations: 2.576 MB / 1.127 GB, free: 11.51 MB / 0.92 GB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Utilities/Strings.mo:139:3-175:14:writable] Warning: Pure function 'Modelica.Utilities.Strings.isEmpty' contains a call to impure function 'Modelica.Utilities.Strings.Advanced.skipWhiteSpace'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Utilities/Strings.mo:216:3-259:11:writable] Warning: Pure function 'Modelica.Utilities.Strings.find' contains a call to impure function 'Modelica.Utilities.Strings.length'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/BoundaryConditions/WeatherData/BaseClasses/getHeaderElementTMY3.mo:2:1-105:25:writable] Warning: Pure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3' contains a call to impure function 'Modelica.Utilities.Streams.readLine'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/BoundaryConditions/WeatherData/BaseClasses/getLongitudeTMY3.mo:2:1-48:21:writable] Warning: Pure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getLongitudeTMY3' contains a call to impure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/BoundaryConditions/WeatherData/BaseClasses/getLatitudeTMY3.mo:2:1-48:20:writable] Warning: Pure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getLatitudeTMY3' contains a call to impure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/BoundaryConditions/WeatherData/BaseClasses/getTimeZoneTMY3.mo:2:1-47:20:writable] Warning: Pure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getTimeZoneTMY3' contains a call to impure function 'Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3'. Notification: Performance of NFTyping.typeBindings: time 0.0185/0.9516, allocations: 5.985 MB / 1.132 GB, free: 5.5 MB / 0.92 GB Notification: Performance of NFTyping.typeClassSections: time 0.5416/1.493, allocations: 5.708 MB / 1.138 GB, free: 9.449 MB / 0.92 GB Notification: Performance of NFFlatten.flatten: time 0.03948/1.533, allocations: 32.64 MB / 1.17 GB, free: 9.406 MB / 0.92 GB Notification: Performance of NFFlatten.resolveConnections: time 0.05344/1.586, allocations: 35.58 MB / 1.205 GB, free: 21.22 MB / 0.9356 GB Notification: Performance of NFEvalConstants.evaluate: time 0.02567/1.612, allocations: 14.48 MB / 1.219 GB, free: 19.94 MB / 0.9356 GB Notification: Performance of NFSimplifyModel.simplify: time 0.03148/1.644, allocations: 16.98 MB / 1.235 GB, free: 17.28 MB / 0.9356 GB Notification: Performance of NFPackage.collectConstants: time 0.01374/1.657, allocations: 4.425 MB / 1.24 GB, free: 17.28 MB / 0.9356 GB Notification: Performance of NFFlatten.collectFunctions: time 0.02299/1.68, allocations: 7.284 MB / 1.247 GB, free: 12.96 MB / 0.9356 GB Notification: Performance of NFScalarize.scalarize: time 0.01908/1.699, allocations: 9.57 MB / 1.256 GB, free: 7.133 MB / 0.9356 GB Notification: Performance of NFVerifyModel.verify: time 0.03271/1.732, allocations: 16.03 MB / 1.272 GB, free: 7.582 MB / 0.9512 GB Notification: Performance of NFConvertDAE.convert: time 0.06297/1.795, allocations: 55.85 MB / 1.326 GB, free: 1.102 MB / 0.9981 GB Notification: Performance of FrontEnd - DAE generated: time 6.903e-06/1.795, allocations: 0 / 1.326 GB, free: 1.102 MB / 0.9981 GB Notification: Performance of FrontEnd: time 1.934e-06/1.795, allocations: 0 / 1.326 GB, free: 1.102 MB / 0.9981 GB Notification: Performance of Transformations before backend: time 0.001488/1.797, allocations: 0 / 1.326 GB, free: 1.102 MB / 0.9981 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 6512 * Number of variables: 6512 Notification: Performance of Generate backend data structure: time 0.09474/1.892, allocations: 30.45 MB / 1.356 GB, free: 2.613 MB / 1.029 GB Notification: Performance of prepare preOptimizeDAE: time 5.355e-05/1.892, allocations: 15.97 kB / 1.356 GB, free: 2.598 MB / 1.029 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1544/2.046, allocations: 29.04 MB / 1.384 GB, free: 5.484 MB / 1.061 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.03695/2.083, allocations: 15.83 MB / 1.4 GB, free: 6.352 MB / 1.076 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001869/2.085, allocations: 1.848 MB / 1.402 GB, free: 4.504 MB / 1.076 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.01141/2.096, allocations: 2.421 MB / 1.404 GB, free: 2.094 MB / 1.076 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.1445/2.241, allocations: 49.34 MB / 1.452 GB, free: 0.5586 MB / 1.123 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0009289/2.242, allocations: 10.44 kB / 1.452 GB, free: 0.5508 MB / 1.123 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.009642/2.252, allocations: 1.008 MB / 1.453 GB, free: 15.54 MB / 1.139 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0007739/2.252, allocations: 0.8422 MB / 1.454 GB, free: 14.7 MB / 1.139 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1756/2.428, allocations: 62.99 MB / 1.516 GB, free: 15.64 MB / 1.201 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 1.228/3.656, allocations: 123.6 MB / 1.636 GB, free: 207.3 MB / 1.233 GB Notification: Performance of preOpt comSubExp (simulation): time 0.1038/3.76, allocations: 42.79 MB / 1.678 GB, free: 206.2 MB / 1.233 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0508/3.811, allocations: 22.6 MB / 1.7 GB, free: 206 MB / 1.233 GB Notification: Performance of preOpt evalFunc (simulation): time 0.00383/3.815, allocations: 1.021 MB / 1.701 GB, free: 205.5 MB / 1.233 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0581/3.873, allocations: 23.44 MB / 1.724 GB, free: 195.3 MB / 1.233 GB Notification: Performance of pre-optimization done (n=2098): time 3.452e-05/3.873, allocations: 1.094 kB / 1.724 GB, free: 195.3 MB / 1.233 GB Notification: Performance of matching and sorting (n=2098): time 0.1794/4.053, allocations: 63.42 MB / 1.786 GB, free: 137 MB / 1.233 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002031/4.053, allocations: 0.6926 MB / 1.787 GB, free: 136.2 MB / 1.233 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01807/4.071, allocations: 11.93 MB / 1.798 GB, free: 124.3 MB / 1.233 GB Notification: Performance of collectPreVariables (initialization): time 0.006925/4.078, allocations: 373.7 kB / 1.799 GB, free: 123.9 MB / 1.233 GB Notification: Performance of collectInitialEqns (initialization): time 0.007308/4.085, allocations: 8.674 MB / 1.807 GB, free: 115.4 MB / 1.233 GB Notification: Performance of collectInitialBindings (initialization): time 0.01066/4.096, allocations: 6.973 MB / 1.814 GB, free: 108.5 MB / 1.233 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.02266/4.119, allocations: 3.717 MB / 1.818 GB, free: 104.8 MB / 1.233 GB Notification: Performance of setup shared object (initialization): time 4.463e-05/4.119, allocations: 301.1 kB / 1.818 GB, free: 104.5 MB / 1.233 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.04774/4.166, allocations: 18.72 MB / 1.836 GB, free: 85.72 MB / 1.233 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.05011/4.217, allocations: 20.86 MB / 1.856 GB, free: 64.48 MB / 1.233 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.09718/4.314, allocations: 39.33 MB / 1.895 GB, free: 24.76 MB / 1.233 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.696e-05/4.314, allocations: 5.5 kB / 1.895 GB, free: 24.75 MB / 1.233 GB Notification: Performance of matching and sorting (n=2334) (initialization): time 0.1358/4.45, allocations: 43.5 MB / 1.937 GB, free: 13.25 MB / 1.264 GB Notification: Performance of prepare postOptimizeDAE: time 5.643e-05/4.45, allocations: 19.94 kB / 1.937 GB, free: 13.23 MB / 1.264 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.789e-05/4.45, allocations: 24 kB / 1.937 GB, free: 13.21 MB / 1.264 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.00349/4.453, allocations: 1.479 MB / 1.939 GB, free: 11.72 MB / 1.264 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.04144/4.495, allocations: 6.439 MB / 1.945 GB, free: 5.488 MB / 1.264 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02304/4.518, allocations: 18.47 MB / 1.963 GB, free: 2.547 MB / 1.279 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03585/4.554, allocations: 4.102 MB / 1.967 GB, free: 14.43 MB / 1.295 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.007911/4.562, allocations: 0.839 MB / 1.968 GB, free: 13.59 MB / 1.295 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 102 * Number of states: 0 () * Number of discrete variables: 38 ($PRE.romHeaMet.internalGains.nextTimeEvent,$whenCondition8,$PRE.romHeaUnm.internalGains.nextTimeEvent,$whenCondition5,$PRE.romCooMet.internalGains.nextTimeEvent,$whenCondition2,$PRE.romCooUnm.internalGains.nextTimeEvent,$whenCondition1,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,romHeaUnm.internalGains.nextTimeEventScaled,$PRE.romHeaUnm.internalGains.nextTimeEventScaled,romHeaUnm.internalGains.nextTimeEvent,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,romHeaMet.internalGains.nextTimeEventScaled,$PRE.romHeaMet.internalGains.nextTimeEventScaled,romHeaMet.internalGains.nextTimeEvent,$whenCondition6,$whenCondition7,weaDat1.conTim.canRepeatWeatherFile,weaDat1.conTimMin.canRepeatWeatherFile,romCooUnm.internalGains.nextTimeEventScaled,$PRE.romCooUnm.internalGains.nextTimeEventScaled,romCooUnm.internalGains.nextTimeEvent,romCooMet.internalGains.nextTimeEventScaled,$PRE.romCooMet.internalGains.nextTimeEventScaled,romCooMet.internalGains.nextTimeEvent,weaDat1.conTim.tNext,$PRE.weaDat1.conTim.tNext,weaDat1.conTimMin.tNext,$PRE.weaDat1.conTimMin.tNext,$whenCondition3,$whenCondition4,conCoo.I.trigger_internal,conHea.I.trigger_internal) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (2214): * Single equations (assignments): 2210 * Array equations: 0 * 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): 4 systems {(3,28,100.0%), (3,28,100.0%), (3,28,100.0%), (3,28,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.02805/4.59, allocations: 7.622 MB / 1.975 GB, free: 6.16 MB / 1.295 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01135/4.601, allocations: 1.548 MB / 1.977 GB, free: 4.594 MB / 1.295 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1592/4.76, allocations: 47.7 MB / 2.024 GB, free: 4.73 MB / 1.342 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0006926/4.761, allocations: 103.6 kB / 2.024 GB, free: 4.629 MB / 1.342 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.315e-05/4.761, allocations: 7.938 kB / 2.024 GB, free: 4.621 MB / 1.342 GB Notification: Performance of postOpt removeConstants (simulation): time 0.7478/5.509, allocations: 6.271 MB / 2.03 GB, free: 0.6147 GB / 1.342 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.008672/5.518, allocations: 460.1 kB / 2.03 GB, free: 0.6147 GB / 1.342 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02918/5.547, allocations: 2.937 MB / 2.033 GB, free: 0.6147 GB / 1.342 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.006581/5.554, allocations: 1.241 MB / 2.034 GB, free: 0.6147 GB / 1.342 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.1532/5.707, allocations: 45.78 MB / 2.079 GB, free: 0.6039 GB / 1.342 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.1748/5.882, allocations: 69.88 MB / 2.147 GB, free: 0.58 GB / 1.342 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0472/5.929, allocations: 21.09 MB / 2.168 GB, free: 0.5642 GB / 1.342 GB Notification: Performance of sorting global known variables: time 0.01535/5.944, allocations: 9 MB / 2.177 GB, free: 0.557 GB / 1.342 GB Notification: Performance of Backend: time 7.51e-07/5.944, allocations: 0 / 2.177 GB, free: 0.557 GB / 1.342 GB Notification: Performance of simCode: created initialization part: time 0.08131/6.026, allocations: 26.26 MB / 2.202 GB, free: 0.5325 GB / 1.342 GB Notification: Performance of SimCode: time 0.07999/6.106, allocations: 43.89 MB / 2.245 GB, free: 0.4902 GB / 1.342 GB Notification: Performance of Templates: time 0.4908/6.596, allocations: 417.3 MB / 2.653 GB, free: 86.34 MB / 1.342 GB make -j1 -f Buildings_8_Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE.makefile (rm -f Buildings_8_Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE.pipe ; mkfifo Buildings_8_Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE.pipe ; head -c 1048576 < Buildings_8_Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE.pipe >> ../files/Buildings_8_Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE.sim & ./Buildings_8_Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_8_Buildings.Experimental.DHC.Loads.Validation.SimpleRoomODE.pipe 2>&1)