Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.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/Buildings 11.0.1-master/package.mo", uses=false) Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/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(Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|aquWel.TAquHot.50.",fileNamePrefix="Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice") translateModel(Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|aquWel.TAquHot.50.",fileNamePrefix="Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00162/0.00162, allocations: 109.2 kB / 16.41 MB, free: 6.512 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.001588/0.001588, allocations: 192.3 kB / 17.35 MB, free: 5.734 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.442/1.442, allocations: 222.9 MB / 241 MB, free: 15.16 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.703/2.703, allocations: 461.9 MB / 0.7355 GB, free: 11.08 MB / 0.6075 GB Notification: Performance of FrontEnd - loaded program: time 0.001706/0.001706, allocations: 67.91 kB / 1.055 GB, free: 7.738 MB / 0.8262 GB Notification: Performance of FrontEnd - Absyn->SCode: time 1.143/1.144, allocations: 157.4 MB / 1.208 GB, free: 13.86 MB / 0.9356 GB Notification: Performance of NFInst.instantiate(Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice): time 0.1069/1.251, allocations: 109.1 MB / 1.315 GB, free: 380 kB / 1.029 GB Notification: Performance of NFInst.instExpressions: time 0.05167/1.303, allocations: 34.63 MB / 1.349 GB, free: 13.66 MB / 1.076 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.007524/1.311, allocations: 143.2 kB / 1.349 GB, free: 13.52 MB / 1.076 GB Notification: Performance of NFTyping.typeComponents: time 0.009602/1.32, allocations: 2.771 MB / 1.352 GB, free: 10.73 MB / 1.076 GB Notification: Performance of NFTyping.typeBindings: time 0.01685/1.337, allocations: 5.517 MB / 1.357 GB, free: 5.195 MB / 1.076 GB Notification: Performance of NFTyping.typeClassSections: time 0.01085/1.348, allocations: 3.975 MB / 1.361 GB, free: 1.242 MB / 1.076 GB Notification: Performance of NFFlatten.flatten: time 0.1954/1.543, allocations: 189 MB / 1.545 GB, free: 3.809 MB / 1.264 GB Notification: Performance of NFFlatten.resolveConnections: time 2.01/3.553, allocations: 76.82 MB / 1.62 GB, free: 35.51 MB / 1.279 GB Notification: Performance of NFEvalConstants.evaluate: time 0.118/3.671, allocations: 57.34 MB / 1.676 GB, free: 29.25 MB / 1.279 GB Notification: Performance of NFSimplifyModel.simplify: time 0.09854/3.77, allocations: 48.87 MB / 1.724 GB, free: 21.22 MB / 1.279 GB Notification: Performance of NFPackage.collectConstants: time 0.03306/3.803, allocations: 6.853 MB / 1.731 GB, free: 21.22 MB / 1.279 GB Notification: Performance of NFFlatten.collectFunctions: time 0.06347/3.866, allocations: 9.968 MB / 1.741 GB, free: 21.21 MB / 1.279 GB Notification: Performance of NFScalarize.scalarize: time 0.04418/3.911, allocations: 18.03 MB / 1.758 GB, free: 16.36 MB / 1.279 GB Notification: Performance of NFVerifyModel.verify: time 0.09991/4.011, allocations: 36.78 MB / 1.794 GB, free: 10.4 MB / 1.295 GB Notification: Performance of NFConvertDAE.convert: time 0.1619/4.173, allocations: 105.7 MB / 1.897 GB, free: 3.16 MB / 1.389 GB Notification: Performance of FrontEnd - DAE generated: time 7.464e-06/4.173, allocations: 0 / 1.897 GB, free: 3.16 MB / 1.389 GB Notification: Performance of FrontEnd: time 2.434e-06/4.173, allocations: 0 / 1.897 GB, free: 3.16 MB / 1.389 GB Notification: Performance of Transformations before backend: time 0.004224/4.177, allocations: 0 / 1.897 GB, free: 3.16 MB / 1.389 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 10359 * Number of variables: 10359 Notification: Performance of Generate backend data structure: time 0.222/4.399, allocations: 66.31 MB / 1.962 GB, free: 1.547 MB / 1.451 GB Notification: Performance of prepare preOptimizeDAE: time 9.704e-05/4.399, allocations: 8.031 kB / 1.962 GB, free: 1.539 MB / 1.451 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05267/4.452, allocations: 7.274 MB / 1.969 GB, free: 10.19 MB / 1.467 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.1586/4.61, allocations: 65.07 MB / 2.033 GB, free: 11.56 MB / 1.529 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.005716/4.616, allocations: 3.004 MB / 2.036 GB, free: 8.582 MB / 1.529 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.01941/4.636, allocations: 4.144 MB / 2.04 GB, free: 4.461 MB / 1.529 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.184/4.82, allocations: 62.59 MB / 2.101 GB, free: 4.07 MB / 1.592 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.003682/4.823, allocations: 260 kB / 2.101 GB, free: 3.875 MB / 1.592 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.01854/4.842, allocations: 1.71 MB / 2.103 GB, free: 2.191 MB / 1.592 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002341/4.844, allocations: 1.827 MB / 2.105 GB, free: 404 kB / 1.592 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1431/4.987, allocations: 51.02 MB / 2.154 GB, free: 13.88 MB / 1.654 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.448/6.435, allocations: 263 MB / 2.411 GB, free: 422.9 MB / 1.67 GB Notification: Performance of preOpt comSubExp (simulation): time 0.06351/6.499, allocations: 30.4 MB / 2.441 GB, free: 392.4 MB / 1.67 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.03827/6.537, allocations: 19.32 MB / 2.46 GB, free: 373.1 MB / 1.67 GB Notification: Performance of preOpt evalFunc (simulation): time 0.1726/6.71, allocations: 60.05 MB / 2.518 GB, free: 313.9 MB / 1.67 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0004663/6.71, allocations: 400.7 kB / 2.519 GB, free: 313.5 MB / 1.67 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.02498/6.735, allocations: 1.923 MB / 2.521 GB, free: 312 MB / 1.67 GB Notification: Performance of pre-optimization done (n=2335): time 8.251e-05/6.735, allocations: 0 / 2.521 GB, free: 312 MB / 1.67 GB Notification: Performance of matching and sorting (n=2672): time 0.3126/7.048, allocations: 116.9 MB / 2.635 GB, free: 192.4 MB / 1.67 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002224/7.048, allocations: 320.3 kB / 2.635 GB, free: 192.1 MB / 1.67 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1011/7.149, allocations: 44.96 MB / 2.679 GB, free: 147.3 MB / 1.67 GB Notification: Performance of collectPreVariables (initialization): time 0.008532/7.158, allocations: 0.5954 MB / 2.68 GB, free: 146.7 MB / 1.67 GB Notification: Performance of collectInitialEqns (initialization): time 0.02978/7.188, allocations: 24.12 MB / 2.703 GB, free: 122.6 MB / 1.67 GB Notification: Performance of collectInitialBindings (initialization): time 0.01711/7.205, allocations: 9.519 MB / 2.713 GB, free: 113 MB / 1.67 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.03683/7.242, allocations: 8.633 MB / 2.721 GB, free: 104.3 MB / 1.67 GB Notification: Performance of setup shared object (initialization): time 6.14e-05/7.242, allocations: 309.1 kB / 2.721 GB, free: 104 MB / 1.67 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.04298/7.285, allocations: 21.66 MB / 2.742 GB, free: 82.34 MB / 1.67 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.05146/7.336, allocations: 30.2 MB / 2.772 GB, free: 49 MB / 1.67 GB Notification: Performance of analyzeInitialSystem (initialization): time 1.07/8.406, allocations: 50.04 MB / 2.821 GB, free: 0.5331 GB / 1.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0004067/8.406, allocations: 63.78 kB / 2.821 GB, free: 0.5331 GB / 1.67 GB Notification: Performance of matching and sorting (n=5524) (initialization): time 0.1834/8.59, allocations: 68.17 MB / 2.887 GB, free: 0.5188 GB / 1.67 GB Notification: Performance of prepare postOptimizeDAE: time 0.0002736/8.59, allocations: 99.91 kB / 2.888 GB, free: 0.5188 GB / 1.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0005468/8.591, allocations: 224.3 kB / 2.888 GB, free: 0.5188 GB / 1.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0266/8.617, allocations: 10.69 MB / 2.898 GB, free: 0.5149 GB / 1.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.04995/8.667, allocations: 11.18 MB / 2.909 GB, free: 0.5141 GB / 1.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.1834/8.851, allocations: 309.4 MB / 3.211 GB, free: 217.8 MB / 1.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.05713/8.908, allocations: 2.655 MB / 3.214 GB, free: 215.2 MB / 1.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0115/8.919, allocations: 1.757 MB / 3.216 GB, free: 213.5 MB / 1.67 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.09721/9.017, allocations: 40.33 MB / 3.255 GB, free: 173.1 MB / 1.67 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.05823/9.075, allocations: 29.94 MB / 3.284 GB, free: 140 MB / 1.67 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.09651/9.172, allocations: 49.56 MB / 3.333 GB, free: 87.29 MB / 1.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0004158/9.172, allocations: 60 kB / 3.333 GB, free: 87.23 MB / 1.67 GB Notification: Performance of matching and sorting (n=5524) (initialization_lambda0): time 0.1726/9.345, allocations: 67.53 MB / 3.399 GB, free: 21.29 MB / 1.67 GB Notification: Performance of prepare postOptimizeDAE: time 0.0004854/9.345, allocations: 100 kB / 3.399 GB, free: 21.19 MB / 1.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0005594/9.346, allocations: 220 kB / 3.399 GB, free: 20.97 MB / 1.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.02357/9.369, allocations: 10.65 MB / 3.409 GB, free: 9.824 MB / 1.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.04632/9.416, allocations: 11.17 MB / 3.42 GB, free: 14.64 MB / 1.686 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.384/10.8, allocations: 309.7 MB / 3.723 GB, free: 264.8 MB / 1.701 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.05397/10.85, allocations: 2.667 MB / 3.725 GB, free: 264.1 MB / 1.701 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01237/10.87, allocations: 1.741 MB / 3.727 GB, free: 263.8 MB / 1.701 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 1015 * Number of states: 0 () * Number of discrete variables: 0 () * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (4786): * Single equations (assignments): 4620 * Array equations: 2 * Algorithm blocks: 0 * Record equations: 2 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 162 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 160 systems {(1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%), (1,4,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 2 systems {(1,14), (1,14)} Notification: Performance of prepare postOptimizeDAE: time 0.02157/10.89, allocations: 2.486 MB / 3.729 GB, free: 261.9 MB / 1.701 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.02273/10.91, allocations: 4.079 MB / 3.733 GB, free: 261.9 MB / 1.701 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1185/11.03, allocations: 44.26 MB / 3.777 GB, free: 244.4 MB / 1.701 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0949/11.12, allocations: 37.67 MB / 3.813 GB, free: 225.1 MB / 1.701 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001922/11.12, allocations: 0 / 3.813 GB, free: 225.1 MB / 1.701 GB Notification: Performance of postOpt removeConstants (simulation): time 0.03568/11.16, allocations: 9.119 MB / 3.822 GB, free: 218.8 MB / 1.701 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01988/11.18, allocations: 0.5389 MB / 3.823 GB, free: 218.3 MB / 1.701 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.04291/11.22, allocations: 1.957 MB / 3.825 GB, free: 216.6 MB / 1.701 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.008756/11.23, allocations: 2.002 MB / 3.827 GB, free: 214.6 MB / 1.701 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.1248/11.36, allocations: 50.58 MB / 3.876 GB, free: 164.3 MB / 1.701 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.137/11.49, allocations: 54.51 MB / 3.929 GB, free: 109.6 MB / 1.701 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.02922/11.52, allocations: 16.31 MB / 3.945 GB, free: 93.23 MB / 1.701 GB Notification: Performance of sorting global known variables: time 0.07597/11.6, allocations: 31.21 MB / 3.976 GB, free: 62.23 MB / 1.701 GB Notification: Performance of Backend: time 3.637e-06/11.6, allocations: 0 / 3.976 GB, free: 62.23 MB / 1.701 GB Notification: Performance of simCode: created initialization part: time 0.244/11.84, allocations: 106.5 MB / 4.08 GB, free: 15.99 MB / 1.764 GB Notification: Performance of SimCode: time 2.158/14, allocations: 141.2 MB / 4.218 GB, free: 0.4917 GB / 1.78 GB Notification: Performance of Templates: time 2.601/16.6, allocations: 1.143 GB / 5.361 GB, free: 42.09 MB / 1.78 GB make -j1 -f Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.makefile (rm -f Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe >> ../files/Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.sim & ./Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice -abortSlowSimulation -alarm=480 -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.pipe 2>&1) diffSimulationResults("Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_Geothermal_Aquifer_Examples_CoolingOffice.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.Geothermal.Aquifer.Examples.CoolingOffice.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) Reference file matches