Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_Buildings.Examples.Tutorial.CDL.System4.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 10.1.1-maint.10.0.x/package.mo", uses=false) Using package Buildings with version 10.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/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.System4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTOut.T|boi.T|temSup.T|temRet.T|temRoo.T|conBoiRet.yVal|conEquSta.onBoi",fileNamePrefix="Buildings_10_Buildings.Examples.Tutorial.CDL.System4") translateModel(Buildings.Examples.Tutorial.CDL.System4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTOut.T|boi.T|temSup.T|temRet.T|temRoo.T|conBoiRet.yVal|conEquSta.onBoi",fileNamePrefix="Buildings_10_Buildings.Examples.Tutorial.CDL.System4") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001205/0.001205, allocations: 117.1 kB / 16.42 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.001114/0.001115, allocations: 186.6 kB / 17.35 MB, free: 5.75 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.469/1.469, allocations: 222.9 MB / 241.1 MB, free: 15.16 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo): time 2.613/2.613, allocations: 437 MB / 0.7112 GB, free: 4.352 MB / 0.5762 GB Notification: Performance of FrontEnd - loaded program: time 0.001527/0.001527, allocations: 63.84 kB / 1.019 GB, free: 9.359 MB / 0.795 GB Notification: Performance of FrontEnd - Absyn->SCode: time 1.121/1.122, allocations: 151.6 MB / 1.167 GB, free: 3.816 MB / 0.8887 GB Notification: Performance of NFInst.instantiate(Buildings.Examples.Tutorial.CDL.System4): time 1.65/2.772, allocations: 0.5137 GB / 1.681 GB, free: 50.82 MB / 1.279 GB Notification: Performance of NFInst.instExpressions: time 0.1186/2.891, allocations: 72.87 MB / 1.752 GB, free: 41.84 MB / 1.279 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.02199/2.913, allocations: 432 kB / 1.753 GB, free: 41.84 MB / 1.279 GB Notification: Performance of NFTyping.typeComponents: time 0.02254/2.936, allocations: 6.004 MB / 1.758 GB, free: 40.14 MB / 1.279 GB Notification: Performance of NFTyping.typeBindings: time 0.05364/2.989, allocations: 14.66 MB / 1.773 GB, free: 33.59 MB / 1.279 GB Notification: Performance of NFTyping.typeClassSections: time 0.03126/3.021, allocations: 10.44 MB / 1.783 GB, free: 27.22 MB / 1.279 GB Notification: Performance of NFFlatten.flatten: time 0.06028/3.081, allocations: 38.32 MB / 1.82 GB, free: 6.891 MB / 1.295 GB Notification: Performance of NFFlatten.resolveConnections: time 0.03436/3.115, allocations: 12.28 MB / 1.832 GB, free: 10.67 MB / 1.311 GB Notification: Performance of NFEvalConstants.evaluate: time 0.04668/3.162, allocations: 12.43 MB / 1.845 GB, free: 14.93 MB / 1.326 GB Notification: Performance of NFSimplifyModel.simplify: time 0.0264/3.189, allocations: 9.328 MB / 1.854 GB, free: 6.273 MB / 1.326 GB Notification: Performance of NFPackage.collectConstants: time 0.008149/3.197, allocations: 1.234 MB / 1.855 GB, free: 5.039 MB / 1.326 GB Notification: Performance of NFFlatten.collectFunctions: time 0.0306/3.227, allocations: 6.602 MB / 1.861 GB, free: 14.81 MB / 1.342 GB Notification: Performance of NFScalarize.scalarize: time 0.01186/3.239, allocations: 3.646 MB / 1.865 GB, free: 11.22 MB / 1.342 GB Notification: Performance of NFVerifyModel.verify: time 0.02518/3.265, allocations: 7.298 MB / 1.872 GB, free: 3.965 MB / 1.342 GB Notification: Performance of NFConvertDAE.convert: time 0.06276/3.327, allocations: 20.98 MB / 1.892 GB, free: 15.66 MB / 1.373 GB Notification: Performance of FrontEnd - DAE generated: time 1.261e-05/3.327, allocations: 4 kB / 1.892 GB, free: 15.66 MB / 1.373 GB Notification: Performance of FrontEnd: time 3.026e-06/3.327, allocations: 0 / 1.892 GB, free: 15.66 MB / 1.373 GB Notification: Performance of Transformations before backend: time 0.001126/3.329, allocations: 4 kB / 1.892 GB, free: 15.65 MB / 1.373 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1881 * Number of variables: 1881 Notification: Performance of Generate backend data structure: time 0.06055/3.389, allocations: 14.32 MB / 1.906 GB, free: 1.301 MB / 1.373 GB Notification: Performance of prepare preOptimizeDAE: time 5.896e-05/3.389, allocations: 8.031 kB / 1.906 GB, free: 1.293 MB / 1.373 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01628/3.406, allocations: 2.294 MB / 1.909 GB, free: 14.98 MB / 1.389 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.03547/3.441, allocations: 12.54 MB / 1.921 GB, free: 2.625 MB / 1.389 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008696/3.442, allocations: 0.5751 MB / 1.922 GB, free: 2.051 MB / 1.389 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.00329/3.445, allocations: 0.7685 MB / 1.922 GB, free: 1.285 MB / 1.389 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.02703/3.472, allocations: 8.686 MB / 1.931 GB, free: 8.32 MB / 1.404 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0004065/3.473, allocations: 19.78 kB / 1.931 GB, free: 8.301 MB / 1.404 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002148/3.475, allocations: 319.4 kB / 1.931 GB, free: 7.992 MB / 1.404 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004006/3.475, allocations: 297.9 kB / 1.931 GB, free: 7.699 MB / 1.404 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01878/3.494, allocations: 7.163 MB / 1.938 GB, free: 0.5234 MB / 1.404 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.07576/3.57, allocations: 42.35 MB / 1.98 GB, free: 3.691 MB / 1.451 GB Notification: Performance of preOpt comSubExp (simulation): time 0.009619/3.58, allocations: 4.721 MB / 1.984 GB, free: 14.88 MB / 1.467 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.005228/3.585, allocations: 2.43 MB / 1.987 GB, free: 12.45 MB / 1.467 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.03053/3.615, allocations: 10.76 MB / 1.997 GB, free: 1.309 MB / 1.467 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.005792/3.621, allocations: 2.568 MB / 2 GB, free: 14.7 MB / 1.482 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.003842/3.625, allocations: 383.7 kB / 2 GB, free: 14.32 MB / 1.482 GB Notification: Performance of pre-optimization done (n=413): time 1.582e-05/3.625, allocations: 0 / 2 GB, free: 14.32 MB / 1.482 GB Notification: Performance of matching and sorting (n=421): time 0.04685/3.672, allocations: 15.04 MB / 2.015 GB, free: 15.03 MB / 1.498 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001775/3.672, allocations: 278.6 kB / 2.015 GB, free: 14.7 MB / 1.498 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02103/3.693, allocations: 9.618 MB / 2.024 GB, free: 5.141 MB / 1.498 GB Notification: Performance of collectPreVariables (initialization): time 0.001233/3.695, allocations: 133.7 kB / 2.025 GB, free: 5.004 MB / 1.498 GB Notification: Performance of collectInitialEqns (initialization): time 0.006177/3.701, allocations: 5.335 MB / 2.03 GB, free: 15.67 MB / 1.514 GB Notification: Performance of collectInitialBindings (initialization): time 0.002285/3.703, allocations: 1.464 MB / 2.031 GB, free: 14.21 MB / 1.514 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.004026/3.707, allocations: 1.368 MB / 2.033 GB, free: 12.84 MB / 1.514 GB Notification: Performance of setup shared object (initialization): time 9.099e-05/3.707, allocations: 313 kB / 2.033 GB, free: 12.53 MB / 1.514 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.005711/3.713, allocations: 2.579 MB / 2.035 GB, free: 9.938 MB / 1.514 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.007262/3.72, allocations: 4.375 MB / 2.04 GB, free: 4.832 MB / 1.514 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.01199/3.732, allocations: 6.497 MB / 2.046 GB, free: 13.7 MB / 1.529 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.516e-05/3.732, allocations: 12 kB / 2.046 GB, free: 13.68 MB / 1.529 GB Notification: Performance of matching and sorting (n=857) (initialization): time 0.02558/3.758, allocations: 8.9 MB / 2.055 GB, free: 4.672 MB / 1.529 GB Notification: Performance of prepare postOptimizeDAE: time 5.738e-05/3.758, allocations: 24 kB / 2.055 GB, free: 4.648 MB / 1.529 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.364e-05/3.758, allocations: 40 kB / 2.055 GB, free: 4.609 MB / 1.529 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.009526/3.768, allocations: 1.77 MB / 2.056 GB, free: 2.832 MB / 1.529 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006098/3.774, allocations: 1.36 MB / 2.058 GB, free: 1.473 MB / 1.529 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01236/3.786, allocations: 8.342 MB / 2.066 GB, free: 8.637 MB / 1.545 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009581/3.796, allocations: 437.5 kB / 2.066 GB, free: 8.215 MB / 1.545 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001454/3.797, allocations: 291.9 kB / 2.067 GB, free: 7.93 MB / 1.545 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01206/3.809, allocations: 4.618 MB / 2.071 GB, free: 3.305 MB / 1.545 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.007497/3.817, allocations: 4.274 MB / 2.075 GB, free: 14.3 MB / 1.561 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01172/3.829, allocations: 6.329 MB / 2.081 GB, free: 7.328 MB / 1.561 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.686e-05/3.829, allocations: 12 kB / 2.081 GB, free: 7.316 MB / 1.561 GB Notification: Performance of matching and sorting (n=857) (initialization_lambda0): time 0.02722/3.856, allocations: 8.857 MB / 2.09 GB, free: 14.34 MB / 1.576 GB Notification: Performance of prepare postOptimizeDAE: time 5e-05/3.856, allocations: 20.97 kB / 2.09 GB, free: 14.32 MB / 1.576 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.398e-05/3.856, allocations: 44 kB / 2.09 GB, free: 14.27 MB / 1.576 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.008774/3.865, allocations: 1.583 MB / 2.092 GB, free: 12.68 MB / 1.576 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005954/3.871, allocations: 1.322 MB / 2.093 GB, free: 11.35 MB / 1.576 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01413/3.885, allocations: 10.46 MB / 2.103 GB, free: 308 kB / 1.576 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01001/3.895, allocations: 453.8 kB / 2.104 GB, free: 15.86 MB / 1.592 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001612/3.897, allocations: 275.9 kB / 2.104 GB, free: 15.59 MB / 1.592 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 186 * Number of states: 0 () * Number of discrete variables: 26 ($PRE.timTab.tab.nextTimeEvent,$whenCondition1,conBoiRet.conPID.con1.y,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,boiSigCon.u,conEquSta.hys.y,$PRE.conEquSta.hys.y,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 (736): * Single equations (assignments): 726 * 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.002578/3.899, allocations: 0.5605 MB / 2.104 GB, free: 15.03 MB / 1.592 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004392/3.904, allocations: 0.9875 MB / 2.105 GB, free: 14.03 MB / 1.592 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0165/3.92, allocations: 6.225 MB / 2.112 GB, free: 7.754 MB / 1.592 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.009244/3.93, allocations: 4.592 MB / 2.116 GB, free: 3.125 MB / 1.592 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.36e-05/3.93, allocations: 0 / 2.116 GB, free: 3.125 MB / 1.592 GB Notification: Performance of postOpt removeConstants (simulation): time 0.005907/3.936, allocations: 1.691 MB / 2.118 GB, free: 1.402 MB / 1.592 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003252/3.939, allocations: 99.98 kB / 2.118 GB, free: 1.305 MB / 1.592 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009736/3.949, allocations: 303.5 kB / 2.118 GB, free: 1.008 MB / 1.592 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00139/3.95, allocations: 343.1 kB / 2.118 GB, free: 0.6719 MB / 1.592 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01612/3.966, allocations: 5.71 MB / 2.124 GB, free: 11.01 MB / 1.607 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01936/3.986, allocations: 7.978 MB / 2.132 GB, free: 2.984 MB / 1.607 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004575/3.99, allocations: 2.141 MB / 2.134 GB, free: 0.8398 MB / 1.607 GB Notification: Performance of sorting global known variables: time 0.01388/4.004, allocations: 6.37 MB / 2.14 GB, free: 10.53 MB / 1.623 GB Notification: Performance of Backend: time 1.723e-06/4.004, allocations: 0 / 2.14 GB, free: 10.53 MB / 1.623 GB Notification: Performance of simCode: created initialization part: time 0.0377/4.042, allocations: 12.33 MB / 2.152 GB, free: 14.52 MB / 1.639 GB Notification: Performance of SimCode: time 0.05482/4.097, allocations: 23.89 MB / 2.175 GB, free: 6.754 MB / 1.654 GB Notification: Performance of Templates: time 1.579/5.675, allocations: 220.2 MB / 2.391 GB, free: 0.5274 GB / 1.654 GB make -j1 -f Buildings_10_Buildings.Examples.Tutorial.CDL.System4.makefile (rm -f Buildings_10_Buildings.Examples.Tutorial.CDL.System4.pipe ; mkfifo Buildings_10_Buildings.Examples.Tutorial.CDL.System4.pipe ; head -c 1048576 < Buildings_10_Buildings.Examples.Tutorial.CDL.System4.pipe >> ../files/Buildings_10_Buildings.Examples.Tutorial.CDL.System4.sim & ./Buildings_10_Buildings.Examples.Tutorial.CDL.System4 -abortSlowSimulation -alarm=480 -emit_protected -lv LOG_STATS > Buildings_10_Buildings.Examples.Tutorial.CDL.System4.pipe 2>&1)