Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_Buildings.Examples.Tutorial.CDL.System2.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.System2,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTOut.T|boi.T|temSup.T|temRet.T|temRoo.T",fileNamePrefix="Buildings_10_Buildings.Examples.Tutorial.CDL.System2")
translateModel(Buildings.Examples.Tutorial.CDL.System2,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTOut.T|boi.T|temSup.T|temRet.T|temRoo.T",fileNamePrefix="Buildings_10_Buildings.Examples.Tutorial.CDL.System2")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001157/0.001157, allocations: 112.3 kB / 16.42 MB, free: 6.031 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.001276/0.001276, allocations: 187.3 kB / 17.35 MB, free: 5.602 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.487/1.487, allocations: 222.9 MB / 241.1 MB, free: 15.15 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.611/2.611, allocations: 437 MB / 0.7112 GB, free: 4.344 MB / 0.5762 GB
Notification: Performance of FrontEnd - loaded program: time 0.001508/0.001509, allocations: 68.11 kB / 1.019 GB, free: 9.371 MB / 0.795 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.086/1.088, allocations: 151.6 MB / 1.167 GB, free: 3.852 MB / 0.8887 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.Tutorial.CDL.System2): time 1.605/2.693, allocations: 0.513 GB / 1.68 GB, free: 50.84 MB / 1.279 GB
Notification: Performance of NFInst.instExpressions: time 0.1199/2.813, allocations: 72.63 MB / 1.751 GB, free: 42.05 MB / 1.279 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0238/2.837, allocations: 434.2 kB / 1.752 GB, free: 42.05 MB / 1.279 GB
Notification: Performance of NFTyping.typeComponents: time 0.02289/2.86, allocations: 5.95 MB / 1.758 GB, free: 40.45 MB / 1.279 GB
Notification: Performance of NFTyping.typeBindings: time 0.05458/2.914, allocations: 14.62 MB / 1.772 GB, free: 33.91 MB / 1.279 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03206/2.946, allocations: 10.35 MB / 1.782 GB, free: 27.62 MB / 1.279 GB
Notification: Performance of NFFlatten.flatten: time 0.05457/3.001, allocations: 38.02 MB / 1.819 GB, free: 7.988 MB / 1.295 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02691/3.028, allocations: 12.03 MB / 1.831 GB, free: 12 MB / 1.311 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03281/3.061, allocations: 12.31 MB / 1.843 GB, free: 396 kB / 1.311 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02117/3.082, allocations: 9.232 MB / 1.852 GB, free: 7.824 MB / 1.326 GB
Notification: Performance of NFPackage.collectConstants: time 0.006451/3.088, allocations: 1.195 MB / 1.853 GB, free: 6.629 MB / 1.326 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02658/3.115, allocations: 6.564 MB / 1.859 GB, free: 448 kB / 1.326 GB
Notification: Performance of NFScalarize.scalarize: time 0.009104/3.124, allocations: 3.582 MB / 1.863 GB, free: 12.91 MB / 1.342 GB
Notification: Performance of NFVerifyModel.verify: time 0.02057/3.145, allocations: 7.177 MB / 1.87 GB, free: 5.773 MB / 1.342 GB
Notification: Performance of NFConvertDAE.convert: time 0.04664/3.192, allocations: 20.69 MB / 1.89 GB, free: 1.742 MB / 1.357 GB
Notification: Performance of FrontEnd - DAE generated: time 6.472e-06/3.192, allocations: 0 / 1.89 GB, free: 1.742 MB / 1.357 GB
Notification: Performance of FrontEnd: time 1.853e-06/3.192, allocations: 0 / 1.89 GB, free: 1.742 MB / 1.357 GB
Notification: Performance of Transformations before backend: time 0.0008144/3.192, allocations: 0 / 1.89 GB, free: 1.742 MB / 1.357 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1832
 * Number of variables: 1832
Notification: Performance of Generate backend data structure: time 0.04394/3.236, allocations: 14.53 MB / 1.904 GB, free: 3.176 MB / 1.373 GB
Notification: Performance of prepare preOptimizeDAE: time 5.804e-05/3.236, allocations: 8.922 kB / 1.904 GB, free: 3.168 MB / 1.373 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01483/3.251, allocations: 2.341 MB / 1.907 GB, free: 0.8203 MB / 1.373 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04316/3.294, allocations: 12.51 MB / 1.919 GB, free: 4.488 MB / 1.389 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001173/3.296, allocations: 0.558 MB / 1.919 GB, free: 3.934 MB / 1.389 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004541/3.3, allocations: 0.7496 MB / 1.92 GB, free: 3.188 MB / 1.389 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.04216/3.342, allocations: 8.499 MB / 1.928 GB, free: 10.4 MB / 1.404 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004908/3.343, allocations: 23.81 kB / 1.928 GB, free: 10.38 MB / 1.404 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003236/3.346, allocations: 302.8 kB / 1.929 GB, free: 10.09 MB / 1.404 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0005614/3.347, allocations: 297.5 kB / 1.929 GB, free: 9.793 MB / 1.404 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03331/3.38, allocations: 7.009 MB / 1.936 GB, free: 2.77 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.1015/3.482, allocations: 41.86 MB / 1.977 GB, free: 6.434 MB / 1.451 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01179/3.494, allocations: 4.704 MB / 1.981 GB, free: 1.645 MB / 1.451 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00528/3.499, allocations: 2.347 MB / 1.984 GB, free: 15.3 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.03351/3.532, allocations: 10.58 MB / 1.994 GB, free: 4.336 MB / 1.467 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007402/3.54, allocations: 2.476 MB / 1.996 GB, free: 1.82 MB / 1.467 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.005292/3.545, allocations: 381 kB / 1.997 GB, free: 1.445 MB / 1.467 GB
Notification: Performance of pre-optimization done (n=395): time 2.167e-05/3.545, allocations: 4 kB / 1.997 GB, free: 1.441 MB / 1.467 GB
Notification: Performance of matching and sorting (n=403): time 0.04939/3.595, allocations: 14.91 MB / 2.011 GB, free: 2.285 MB / 1.482 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001775/3.595, allocations: 244.8 kB / 2.012 GB, free: 1.996 MB / 1.482 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02305/3.618, allocations: 9.535 MB / 2.021 GB, free: 8.516 MB / 1.498 GB
Notification: Performance of collectPreVariables (initialization): time 0.001407/3.619, allocations: 125.7 kB / 2.021 GB, free: 8.387 MB / 1.498 GB
Notification: Performance of collectInitialEqns (initialization): time 0.008589/3.628, allocations: 5.365 MB / 2.026 GB, free: 3.027 MB / 1.498 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003423/3.632, allocations: 1.475 MB / 2.028 GB, free: 1.574 MB / 1.498 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.006099/3.638, allocations: 1.349 MB / 2.029 GB, free: 220 kB / 1.498 GB
Notification: Performance of setup shared object (initialization): time 0.0001637/3.638, allocations: 301.1 kB / 2.029 GB, free: 15.92 MB / 1.514 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.006943/3.645, allocations: 2.523 MB / 2.032 GB, free: 13.38 MB / 1.514 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.008607/3.653, allocations: 4.266 MB / 2.036 GB, free: 8.398 MB / 1.514 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01411/3.668, allocations: 6.355 MB / 2.042 GB, free: 1.418 MB / 1.514 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.519e-05/3.668, allocations: 15.94 kB / 2.042 GB, free: 1.402 MB / 1.514 GB
Notification: Performance of matching and sorting (n=838) (initialization): time 0.03057/3.698, allocations: 9.114 MB / 2.051 GB, free: 8.184 MB / 1.529 GB
Notification: Performance of prepare postOptimizeDAE: time 7.066e-05/3.698, allocations: 20 kB / 2.051 GB, free: 8.164 MB / 1.529 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.279e-05/3.698, allocations: 40 kB / 2.051 GB, free: 8.125 MB / 1.529 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01029/3.709, allocations: 1.769 MB / 2.053 GB, free: 6.348 MB / 1.529 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006564/3.715, allocations: 1.321 MB / 2.054 GB, free: 5.027 MB / 1.529 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0125/3.728, allocations: 8.223 MB / 2.062 GB, free: 12.32 MB / 1.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01085/3.739, allocations: 416.5 kB / 2.062 GB, free: 11.91 MB / 1.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001682/3.74, allocations: 283.9 kB / 2.063 GB, free: 11.63 MB / 1.545 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01358/3.754, allocations: 4.547 MB / 2.067 GB, free: 7.078 MB / 1.545 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.009122/3.763, allocations: 4.201 MB / 2.071 GB, free: 2.16 MB / 1.545 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01316/3.776, allocations: 6.21 MB / 2.077 GB, free: 11.37 MB / 1.561 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.612e-05/3.777, allocations: 12 kB / 2.077 GB, free: 11.36 MB / 1.561 GB
Notification: Performance of matching and sorting (n=838) (initialization_lambda0): time 0.02654/3.803, allocations: 8.475 MB / 2.086 GB, free: 2.855 MB / 1.561 GB
Notification: Performance of prepare postOptimizeDAE: time 5.59e-05/3.803, allocations: 27.94 kB / 2.086 GB, free: 2.828 MB / 1.561 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.733e-05/3.803, allocations: 40 kB / 2.086 GB, free: 2.789 MB / 1.561 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009095/3.812, allocations: 1.563 MB / 2.087 GB, free: 1.211 MB / 1.561 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006029/3.818, allocations: 1.299 MB / 2.089 GB, free: 15.91 MB / 1.576 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0161/3.835, allocations: 10.59 MB / 2.099 GB, free: 4.715 MB / 1.576 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009757/3.844, allocations: 437.3 kB / 2.099 GB, free: 4.289 MB / 1.576 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001589/3.846, allocations: 279.9 kB / 2.1 GB, free: 4.016 MB / 1.576 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 183
 * Number of states: 0 ()
 * Number of discrete variables: 22 ($PRE.timTab.tab.nextTimeEvent,$whenCondition1,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 (717):
 * Single equations (assignments): 707
 * 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
   {(3,8), (13,22), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.002774/3.849, allocations: 0.5424 MB / 2.1 GB, free: 3.469 MB / 1.576 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004533/3.853, allocations: 1.025 MB / 2.101 GB, free: 2.438 MB / 1.576 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0189/3.872, allocations: 6.069 MB / 2.107 GB, free: 12.32 MB / 1.592 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01154/3.884, allocations: 4.469 MB / 2.111 GB, free: 7.805 MB / 1.592 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.562e-05/3.884, allocations: 0 / 2.111 GB, free: 7.805 MB / 1.592 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006185/3.89, allocations: 1.708 MB / 2.113 GB, free: 6.07 MB / 1.592 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003171/3.893, allocations: 95.98 kB / 2.113 GB, free: 5.977 MB / 1.592 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006992/3.9, allocations: 295.5 kB / 2.113 GB, free: 5.688 MB / 1.592 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008927/3.901, allocations: 330.9 kB / 2.114 GB, free: 5.363 MB / 1.592 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01578/3.917, allocations: 5.561 MB / 2.119 GB, free: 15.84 MB / 1.607 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01682/3.934, allocations: 7.779 MB / 2.127 GB, free: 8.016 MB / 1.607 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004198/3.938, allocations: 2.07 MB / 2.129 GB, free: 5.941 MB / 1.607 GB
Notification: Performance of sorting global known variables: time 0.01531/3.953, allocations: 6.311 MB / 2.135 GB, free: 15.69 MB / 1.623 GB
Notification: Performance of Backend: time 1.042e-06/3.953, allocations: 0 / 2.135 GB, free: 15.69 MB / 1.623 GB
Notification: Performance of simCode: created initialization part: time 0.03858/3.992, allocations: 12.17 MB / 2.147 GB, free: 3.844 MB / 1.623 GB
Notification: Performance of SimCode: time 0.05785/4.05, allocations: 23.94 MB / 2.17 GB, free: 12 MB / 1.654 GB
Notification: Performance of Templates: time 0.9613/5.011, allocations: 217.9 MB / 2.383 GB, free: 0.542 GB / 1.654 GB
make -j1 -f Buildings_10_Buildings.Examples.Tutorial.CDL.System2.makefile
(rm -f Buildings_10_Buildings.Examples.Tutorial.CDL.System2.pipe ; mkfifo Buildings_10_Buildings.Examples.Tutorial.CDL.System2.pipe ; head -c 1048576 < Buildings_10_Buildings.Examples.Tutorial.CDL.System2.pipe >> ../files/Buildings_10_Buildings.Examples.Tutorial.CDL.System2.sim & ./Buildings_10_Buildings.Examples.Tutorial.CDL.System2  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_10_Buildings.Examples.Tutorial.CDL.System2.pipe 2>&1)