Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Examples.Tutorial.CDL.System3.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.0-master/package.mo", uses=false) Using package Buildings with version 11.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.0-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.Examples.Tutorial.CDL.System3,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTOut.T|boi.T|temSup.T|temRet.T|temRoo.T",fileNamePrefix="Buildings_latest_Buildings.Examples.Tutorial.CDL.System3") translateModel(Buildings.Examples.Tutorial.CDL.System3,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTOut.T|boi.T|temSup.T|temRet.T|temRoo.T",fileNamePrefix="Buildings_latest_Buildings.Examples.Tutorial.CDL.System3") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001542/0.001549, allocations: 108.1 kB / 16.38 MB, free: 6.484 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.002026/0.002026, allocations: 190.6 kB / 17.32 MB, free: 5.82 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.448/1.448, allocations: 222.9 MB / 241 MB, free: 15.2 MB / 206.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.0-master/Experimental/DHC/UsersGuide/package.mo:2:1-389:15:writable] Warning: UsersGuide was referenced in the package.order file, but was not found in package.mo, UsersGuide/package.mo or UsersGuide.mo. Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.0-master/package.mo): time 2.731/2.731, allocations: 442.6 MB / 0.7166 GB, free: 14.66 MB / 0.5919 GB Notification: Performance of FrontEnd - loaded program: time 0.001318/0.001318, allocations: 61.03 kB / 0.8774 GB, free: 10.99 MB / 0.6544 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.3914/0.3928, allocations: 153 MB / 1.027 GB, free: 2.066 MB / 0.795 GB Notification: Performance of NFInst.instantiate(Buildings.Examples.Tutorial.CDL.System3): time 2.31/2.703, allocations: 0.5136 GB / 1.54 GB, free: 87.71 MB / 1.232 GB Notification: Performance of NFInst.instExpressions: time 0.1289/2.832, allocations: 72.85 MB / 1.612 GB, free: 87.09 MB / 1.232 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.02888/2.861, allocations: 438.7 kB / 1.612 GB, free: 87.09 MB / 1.232 GB Notification: Performance of NFTyping.typeComponents: time 0.02266/2.883, allocations: 5.854 MB / 1.618 GB, free: 86.98 MB / 1.232 GB Notification: Performance of NFTyping.typeBindings: time 0.05178/2.935, allocations: 14.02 MB / 1.631 GB, free: 86.4 MB / 1.232 GB Notification: Performance of NFTyping.typeClassSections: time 0.03419/2.969, allocations: 10.4 MB / 1.642 GB, free: 86.1 MB / 1.232 GB Notification: Performance of NFFlatten.flatten: time 0.06159/3.031, allocations: 38.24 MB / 1.679 GB, free: 80.84 MB / 1.232 GB Notification: Performance of NFFlatten.resolveConnections: time 0.02527/3.056, allocations: 12.25 MB / 1.691 GB, free: 73.77 MB / 1.232 GB Notification: Performance of NFEvalConstants.evaluate: time 0.03202/3.088, allocations: 12.07 MB / 1.703 GB, free: 67.77 MB / 1.232 GB Notification: Performance of NFSimplifyModel.simplify: time 0.02044/3.109, allocations: 9.31 MB / 1.712 GB, free: 59.54 MB / 1.232 GB Notification: Performance of NFPackage.collectConstants: time 0.006618/3.116, allocations: 1.227 MB / 1.713 GB, free: 58.32 MB / 1.232 GB Notification: Performance of NFFlatten.collectFunctions: time 0.02283/3.138, allocations: 6.592 MB / 1.719 GB, free: 52.42 MB / 1.232 GB Notification: Performance of NFScalarize.scalarize: time 0.006714/3.145, allocations: 3.645 MB / 1.723 GB, free: 48.91 MB / 1.232 GB Notification: Performance of NFVerifyModel.verify: time 0.01953/3.165, allocations: 7.284 MB / 1.73 GB, free: 41.76 MB / 1.232 GB Notification: Performance of NFConvertDAE.convert: time 0.04507/3.21, allocations: 20.93 MB / 1.75 GB, free: 21.62 MB / 1.232 GB Notification: Performance of FrontEnd - DAE generated: time 6.412e-06/3.21, allocations: 0 / 1.75 GB, free: 21.62 MB / 1.232 GB Notification: Performance of FrontEnd: time 2.345e-06/3.21, allocations: 0 / 1.75 GB, free: 21.62 MB / 1.232 GB Notification: Performance of Transformations before backend: time 0.0008477/3.211, allocations: 0 / 1.75 GB, free: 21.62 MB / 1.232 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1875 * Number of variables: 1875 Notification: Performance of Generate backend data structure: time 0.04817/3.259, allocations: 14.31 MB / 1.764 GB, free: 7.387 MB / 1.232 GB Notification: Performance of prepare preOptimizeDAE: time 6.659e-05/3.259, allocations: 12.03 kB / 1.764 GB, free: 7.375 MB / 1.232 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02117/3.28, allocations: 2.297 MB / 1.767 GB, free: 5.062 MB / 1.232 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.03207/3.312, allocations: 12.52 MB / 1.779 GB, free: 8.934 MB / 1.248 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005549/3.313, allocations: 0.5677 MB / 1.779 GB, free: 8.367 MB / 1.248 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.002388/3.315, allocations: 0.7653 MB / 1.78 GB, free: 7.605 MB / 1.248 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.02192/3.337, allocations: 8.671 MB / 1.789 GB, free: 14.69 MB / 1.264 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0003796/3.338, allocations: 24.8 kB / 1.789 GB, free: 14.67 MB / 1.264 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002293/3.34, allocations: 310.8 kB / 1.789 GB, free: 14.37 MB / 1.264 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003401/3.34, allocations: 297.4 kB / 1.789 GB, free: 14.08 MB / 1.264 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02326/3.364, allocations: 7.147 MB / 1.796 GB, free: 6.988 MB / 1.264 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.09199/3.456, allocations: 42.37 MB / 1.838 GB, free: 10.55 MB / 1.311 GB Notification: Performance of preOpt comSubExp (simulation): time 0.008207/3.464, allocations: 4.699 MB / 1.842 GB, free: 5.793 MB / 1.311 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.003998/3.468, allocations: 2.425 MB / 1.845 GB, free: 3.367 MB / 1.311 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 evalFunc (simulation): time 0.02647/3.494, allocations: 10.72 MB / 1.855 GB, free: 8.273 MB / 1.326 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004851/3.499, allocations: 2.52 MB / 1.858 GB, free: 5.715 MB / 1.326 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.003945/3.503, allocations: 395.5 kB / 1.858 GB, free: 5.328 MB / 1.326 GB Notification: Performance of pre-optimization done (n=406): time 1.592e-05/3.503, allocations: 0 / 1.858 GB, free: 5.328 MB / 1.326 GB Notification: Performance of matching and sorting (n=414): time 0.03914/3.542, allocations: 14.97 MB / 1.873 GB, free: 6.133 MB / 1.342 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001506/3.543, allocations: 274.6 kB / 1.873 GB, free: 5.809 MB / 1.342 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01735/3.56, allocations: 9.635 MB / 1.882 GB, free: 12.23 MB / 1.357 GB Notification: Performance of collectPreVariables (initialization): time 0.001356/3.561, allocations: 129.7 kB / 1.882 GB, free: 12.1 MB / 1.357 GB Notification: Performance of collectInitialEqns (initialization): time 0.005712/3.567, allocations: 5.368 MB / 1.888 GB, free: 6.727 MB / 1.357 GB Notification: Performance of collectInitialBindings (initialization): time 0.00235/3.569, allocations: 1.433 MB / 1.889 GB, free: 5.305 MB / 1.357 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.002335/3.572, allocations: 1.371 MB / 1.89 GB, free: 3.926 MB / 1.357 GB Notification: Performance of setup shared object (initialization): time 0.0001038/3.572, allocations: 313.1 kB / 1.891 GB, free: 3.617 MB / 1.357 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.005016/3.577, allocations: 2.561 MB / 1.893 GB, free: 1.047 MB / 1.357 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.006297/3.583, allocations: 4.367 MB / 1.897 GB, free: 11.98 MB / 1.373 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.01067/3.594, allocations: 6.471 MB / 1.904 GB, free: 5.051 MB / 1.373 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.15e-05/3.594, allocations: 12 kB / 1.904 GB, free: 5.039 MB / 1.373 GB Notification: Performance of matching and sorting (n=854) (initialization): time 0.02478/3.619, allocations: 9.204 MB / 1.913 GB, free: 12 MB / 1.389 GB Notification: Performance of prepare postOptimizeDAE: time 6.223e-05/3.619, allocations: 25.56 kB / 1.913 GB, free: 11.98 MB / 1.389 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.808e-05/3.619, allocations: 40 kB / 1.913 GB, free: 11.94 MB / 1.389 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.009032/3.628, allocations: 1.78 MB / 1.914 GB, free: 10.16 MB / 1.389 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00607/3.634, allocations: 1.356 MB / 1.916 GB, free: 8.883 MB / 1.389 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01188/3.646, allocations: 8.344 MB / 1.924 GB, free: 96 kB / 1.389 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0105/3.657, allocations: 416.8 kB / 1.924 GB, free: 15.69 MB / 1.404 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001495/3.658, allocations: 291.9 kB / 1.925 GB, free: 15.4 MB / 1.404 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01127/3.669, allocations: 4.61 MB / 1.929 GB, free: 10.79 MB / 1.404 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.008053/3.677, allocations: 4.265 MB / 1.933 GB, free: 5.82 MB / 1.404 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01376/3.691, allocations: 6.302 MB / 1.939 GB, free: 15.05 MB / 1.42 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.983e-05/3.691, allocations: 15.19 kB / 1.939 GB, free: 15.04 MB / 1.42 GB Notification: Performance of matching and sorting (n=854) (initialization_lambda0): time 0.02414/3.716, allocations: 8.54 MB / 1.948 GB, free: 6.527 MB / 1.42 GB Notification: Performance of prepare postOptimizeDAE: time 4.9e-05/3.716, allocations: 20 kB / 1.948 GB, free: 6.508 MB / 1.42 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.778e-05/3.716, allocations: 47.94 kB / 1.948 GB, free: 6.461 MB / 1.42 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.00866/3.724, allocations: 1.579 MB / 1.949 GB, free: 4.871 MB / 1.42 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005803/3.73, allocations: 1.314 MB / 1.951 GB, free: 3.555 MB / 1.42 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01564/3.746, allocations: 10.56 MB / 1.961 GB, free: 8.434 MB / 1.436 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00998/3.756, allocations: 441.1 kB / 1.961 GB, free: 8.004 MB / 1.436 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001533/3.757, allocations: 280.2 kB / 1.962 GB, free: 7.73 MB / 1.436 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 186 * Number of states: 0 () * Number of discrete variables: 23 ($PRE.timTab.tab.nextTimeEvent,$whenCondition1,conBoiRet.conPID.con1.y,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,timTab.tab.nextTimeEventScaled,$PRE.timTab.tab.nextTimeEventScaled,timTab.tab.nextTimeEvent,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (733): * Single equations (assignments): 723 * Array equations: 2 * Algorithm blocks: 0 * Record equations: 2 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 1 * Torn equation systems: 5 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details (not torn): * Constant Jacobian (size): 0 systems * Linear Jacobian (size,density): 0 systems * Non-linear Jacobian (size): 1 system {1} * Without analytic Jacobian (size): 0 systems Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 2 systems {(1,5,100.0%), (1,4,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 3 systems {(5,6), (13,22), (1,2)} Notification: Performance of prepare postOptimizeDAE: time 0.002506/3.76, allocations: 0.5578 MB / 1.962 GB, free: 7.164 MB / 1.436 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004347/3.764, allocations: 0.9991 MB / 1.963 GB, free: 6.152 MB / 1.436 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01663/3.781, allocations: 6.161 MB / 1.969 GB, free: 15.94 MB / 1.451 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00995/3.791, allocations: 4.556 MB / 1.974 GB, free: 11.35 MB / 1.451 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.319e-05/3.791, allocations: 0 / 1.974 GB, free: 11.35 MB / 1.451 GB Notification: Performance of postOpt removeConstants (simulation): time 0.005561/3.797, allocations: 1.683 MB / 1.975 GB, free: 9.633 MB / 1.451 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003123/3.8, allocations: 99.98 kB / 1.975 GB, free: 9.535 MB / 1.451 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009068/3.809, allocations: 295.5 kB / 1.976 GB, free: 9.246 MB / 1.451 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001254/3.81, allocations: 335.1 kB / 1.976 GB, free: 8.918 MB / 1.451 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01724/3.827, allocations: 5.676 MB / 1.982 GB, free: 3.289 MB / 1.451 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01656/3.844, allocations: 7.894 MB / 1.989 GB, free: 11.36 MB / 1.467 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004067/3.848, allocations: 2.125 MB / 1.991 GB, free: 9.227 MB / 1.467 GB Notification: Performance of sorting global known variables: time 0.01571/3.864, allocations: 6.386 MB / 1.998 GB, free: 2.898 MB / 1.467 GB Notification: Performance of Backend: time 1.613e-06/3.864, allocations: 0 / 1.998 GB, free: 2.898 MB / 1.467 GB Notification: Performance of simCode: created initialization part: time 0.03911/3.903, allocations: 12.31 MB / 2.01 GB, free: 7.078 MB / 1.482 GB Notification: Performance of SimCode: time 0.05617/3.959, allocations: 23.86 MB / 2.033 GB, free: 15.46 MB / 1.514 GB Notification: Performance of Templates: time 0.9008/4.86, allocations: 217.1 MB / 2.245 GB, free: 0.6295 GB / 1.561 GB make -j1 -f Buildings_latest_Buildings.Examples.Tutorial.CDL.System3.makefile (rm -f Buildings_latest_Buildings.Examples.Tutorial.CDL.System3.pipe ; mkfifo Buildings_latest_Buildings.Examples.Tutorial.CDL.System3.pipe ; head -c 1048576 < Buildings_latest_Buildings.Examples.Tutorial.CDL.System3.pipe >> ../files/Buildings_latest_Buildings.Examples.Tutorial.CDL.System3.sim & ./Buildings_latest_Buildings.Examples.Tutorial.CDL.System3 -abortSlowSimulation -alarm=480 -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Examples.Tutorial.CDL.System3.pipe 2>&1)