Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_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 11.1.0-maint.11.x/package.mo", uses=false)
Using package Buildings with version 11.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.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_11_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_11_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.002108/0.002108, allocations: 115.9 kB / 16.81 MB, free: 5.766 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.002194/0.002194, allocations: 196.7 kB / 17.77 MB, free: 5.117 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.511/1.511, allocations: 225.6 MB / 244.2 MB, free: 13.89 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo): time 2.822/2.822, allocations: 476.7 MB / 0.7556 GB, free: 11.36 MB / 0.6231 GB
Notification: Performance of FrontEnd - loaded program: time 0.001963/0.001963, allocations: 71.77 kB / 1.097 GB, free: 11.73 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4018/0.4038, allocations: 168.7 MB / 1.262 GB, free: 12.94 MB / 0.9825 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.Tutorial.CDL.System4): time 1.447/1.85, allocations: 0.5168 GB / 1.779 GB, free: 11.36 MB / 1.279 GB
Notification: Performance of NFInst.instExpressions: time 0.1289/1.979, allocations: 73.03 MB / 1.85 GB, free: 3.996 MB / 1.342 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02311/2.002, allocations: 437.5 kB / 1.851 GB, free: 3.566 MB / 1.342 GB
Notification: Performance of NFTyping.typeComponents: time 0.02692/2.029, allocations: 6.051 MB / 1.857 GB, free: 13.48 MB / 1.357 GB
Notification: Performance of NFTyping.typeBindings: time 0.05705/2.086, allocations: 14.67 MB / 1.871 GB, free: 14.77 MB / 1.373 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03094/2.117, allocations: 10.58 MB / 1.881 GB, free: 4.27 MB / 1.373 GB
Notification: Performance of NFFlatten.flatten: time 0.0609/2.178, allocations: 38.45 MB / 1.919 GB, free: 13.73 MB / 1.42 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02193/2.2, allocations: 10.17 MB / 1.929 GB, free: 3.426 MB / 1.42 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03063/2.231, allocations: 12.45 MB / 1.941 GB, free: 6.98 MB / 1.436 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02056/2.251, allocations: 9.783 MB / 1.95 GB, free: 13.16 MB / 1.451 GB
Notification: Performance of NFPackage.collectConstants: time 0.00656/2.258, allocations: 1.23 MB / 1.952 GB, free: 11.93 MB / 1.451 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02197/2.28, allocations: 6.736 MB / 1.958 GB, free: 5.184 MB / 1.451 GB
Notification: Performance of NFScalarize.scalarize: time 0.007411/2.287, allocations: 3.787 MB / 1.962 GB, free: 1.383 MB / 1.451 GB
Notification: Performance of NFVerifyModel.verify: time 0.01697/2.304, allocations: 7.29 MB / 1.969 GB, free: 10.06 MB / 1.467 GB
Notification: Performance of NFConvertDAE.convert: time 0.04442/2.349, allocations: 21.08 MB / 1.99 GB, free: 4.898 MB / 1.482 GB
Notification: Performance of FrontEnd - DAE generated: time 6.682e-06/2.349, allocations: 0 / 1.99 GB, free: 4.898 MB / 1.482 GB
Notification: Performance of FrontEnd: time 2.084e-06/2.349, allocations: 0 / 1.99 GB, free: 4.898 MB / 1.482 GB
Notification: Performance of Transformations before backend: time 0.0009029/2.349, allocations: 0 / 1.99 GB, free: 4.898 MB / 1.482 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.04734/2.397, allocations: 14.77 MB / 2.004 GB, free: 5.957 MB / 1.498 GB
Notification: Performance of prepare preOptimizeDAE: time 5.945e-05/2.397, allocations: 12.58 kB / 2.004 GB, free: 5.945 MB / 1.498 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0144/2.411, allocations: 2.365 MB / 2.006 GB, free: 3.57 MB / 1.498 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03232/2.444, allocations: 12.62 MB / 2.019 GB, free: 6.852 MB / 1.514 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008003/2.444, allocations: 0.5729 MB / 2.019 GB, free: 6.277 MB / 1.514 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003122/2.448, allocations: 0.7655 MB / 2.02 GB, free: 5.512 MB / 1.514 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02251/2.47, allocations: 8.69 MB / 2.028 GB, free: 12.53 MB / 1.529 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000176/2.47, allocations: 19.83 kB / 2.028 GB, free: 12.51 MB / 1.529 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001078/2.471, allocations: 316 kB / 2.029 GB, free: 12.2 MB / 1.529 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003094/2.472, allocations: 301.9 kB / 2.029 GB, free: 11.9 MB / 1.529 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01839/2.49, allocations: 7.17 MB / 2.036 GB, free: 4.719 MB / 1.529 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.07946/2.569, allocations: 42.45 MB / 2.078 GB, free: 7.461 MB / 1.576 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00928/2.579, allocations: 4.437 MB / 2.082 GB, free: 2.926 MB / 1.576 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005034/2.584, allocations: 2.223 MB / 2.084 GB, free: 0.707 MB / 1.576 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.03386/2.618, allocations: 10.78 MB / 2.095 GB, free: 5.434 MB / 1.592 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.006742/2.624, allocations: 2.563 MB / 2.097 GB, free: 2.836 MB / 1.592 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004434/2.629, allocations: 408.9 kB / 2.097 GB, free: 2.434 MB / 1.592 GB
Notification: Performance of pre-optimization done (n=413): time 2.181e-05/2.629, allocations: 0 / 2.097 GB, free: 2.434 MB / 1.592 GB
Notification: Performance of matching and sorting (n=421): time 0.05034/2.679, allocations: 15.21 MB / 2.112 GB, free: 2.977 MB / 1.607 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001889/2.679, allocations: 274.6 kB / 2.113 GB, free: 2.652 MB / 1.607 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0243/2.704, allocations: 9.623 MB / 2.122 GB, free: 9.09 MB / 1.623 GB
Notification: Performance of collectPreVariables (initialization): time 0.00149/2.705, allocations: 133.7 kB / 2.122 GB, free: 8.953 MB / 1.623 GB
Notification: Performance of collectInitialEqns (initialization): time 0.007809/2.713, allocations: 5.424 MB / 2.127 GB, free: 3.504 MB / 1.623 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00271/2.716, allocations: 1.538 MB / 2.129 GB, free: 1.953 MB / 1.623 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.005281/2.721, allocations: 1.377 MB / 2.13 GB, free: 0.5664 MB / 1.623 GB
Notification: Performance of setup shared object (initialization): time 0.0001625/2.721, allocations: 305.1 kB / 2.131 GB, free: 272 kB / 1.623 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007008/2.728, allocations: 2.579 MB / 2.133 GB, free: 13.67 MB / 1.639 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.009221/2.737, allocations: 4.376 MB / 2.137 GB, free: 8.562 MB / 1.639 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01416/2.752, allocations: 6.496 MB / 2.144 GB, free: 1.43 MB / 1.639 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.714e-05/2.752, allocations: 12 kB / 2.144 GB, free: 1.418 MB / 1.639 GB
Notification: Performance of matching and sorting (n=857) (initialization): time 0.02754/2.779, allocations: 8.937 MB / 2.152 GB, free: 8.363 MB / 1.654 GB
Notification: Performance of prepare postOptimizeDAE: time 6.454e-05/2.779, allocations: 25 kB / 2.152 GB, free: 8.34 MB / 1.654 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.908e-05/2.779, allocations: 40 kB / 2.152 GB, free: 8.301 MB / 1.654 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009701/2.789, allocations: 1.776 MB / 2.154 GB, free: 6.508 MB / 1.654 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006822/2.796, allocations: 1.353 MB / 2.156 GB, free: 5.152 MB / 1.654 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0133/2.809, allocations: 8.354 MB / 2.164 GB, free: 12.3 MB / 1.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00994/2.819, allocations: 427.9 kB / 2.164 GB, free: 11.88 MB / 1.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001662/2.821, allocations: 287.9 kB / 2.164 GB, free: 11.6 MB / 1.67 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01257/2.833, allocations: 4.616 MB / 2.169 GB, free: 6.977 MB / 1.67 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.00863/2.842, allocations: 4.282 MB / 2.173 GB, free: 1.965 MB / 1.67 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01369/2.856, allocations: 6.313 MB / 2.179 GB, free: 11.01 MB / 1.686 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.248e-05/2.856, allocations: 12 kB / 2.179 GB, free: 11 MB / 1.686 GB
Notification: Performance of matching and sorting (n=857) (initialization_lambda0): time 0.03151/2.887, allocations: 8.897 MB / 2.188 GB, free: 1.984 MB / 1.686 GB
Notification: Performance of prepare postOptimizeDAE: time 5.561e-05/2.887, allocations: 28.03 kB / 2.188 GB, free: 1.957 MB / 1.686 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.558e-05/2.887, allocations: 40 kB / 2.188 GB, free: 1.918 MB / 1.686 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008787/2.896, allocations: 1.581 MB / 2.19 GB, free: 328 kB / 1.686 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.7738/3.67, allocations: 1.304 MB / 2.191 GB, free: 0.6529 GB / 1.686 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01459/3.684, allocations: 10.48 MB / 2.201 GB, free: 0.6467 GB / 1.686 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01077/3.695, allocations: 451.7 kB / 2.201 GB, free: 0.6467 GB / 1.686 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001857/3.697, allocations: 279.8 kB / 2.202 GB, free: 0.6467 GB / 1.686 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.002078/3.699, allocations: 0.5625 MB / 2.202 GB, free: 0.6465 GB / 1.686 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003747/3.703, allocations: 1.041 MB / 2.203 GB, free: 0.6465 GB / 1.686 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01568/3.719, allocations: 6.203 MB / 2.209 GB, free: 0.6451 GB / 1.686 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01086/3.729, allocations: 4.575 MB / 2.214 GB, free: 0.6434 GB / 1.686 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.735e-05/3.729, allocations: 0 / 2.214 GB, free: 0.6434 GB / 1.686 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006767/3.736, allocations: 1.734 MB / 2.215 GB, free: 0.6429 GB / 1.686 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004695/3.741, allocations: 101.3 kB / 2.216 GB, free: 0.6428 GB / 1.686 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009122/3.75, allocations: 305.2 kB / 2.216 GB, free: 0.6428 GB / 1.686 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001712/3.752, allocations: 342.3 kB / 2.216 GB, free: 0.6427 GB / 1.686 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01855/3.77, allocations: 5.721 MB / 2.222 GB, free: 0.6409 GB / 1.686 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.02131/3.792, allocations: 8.014 MB / 2.23 GB, free: 0.6381 GB / 1.686 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004265/3.796, allocations: 1.993 MB / 2.232 GB, free: 0.6374 GB / 1.686 GB
Notification: Performance of sorting global known variables: time 0.01443/3.81, allocations: 6.369 MB / 2.238 GB, free: 0.6353 GB / 1.686 GB
Notification: Performance of Backend: time 1.042e-06/3.81, allocations: 0 / 2.238 GB, free: 0.6353 GB / 1.686 GB
Notification: Performance of simCode: created initialization part: time 0.03977/3.85, allocations: 11.72 MB / 2.249 GB, free: 0.6317 GB / 1.686 GB
Notification: Performance of SimCode: time 0.06471/3.915, allocations: 24.32 MB / 2.273 GB, free: 0.6214 GB / 1.686 GB
Notification: Performance of Templates: time 0.32/4.235, allocations: 224.1 MB / 2.492 GB, free: 415.8 MB / 1.686 GB
make -j1 -f Buildings_11_Buildings.Examples.Tutorial.CDL.System4.makefile
(rm -f Buildings_11_Buildings.Examples.Tutorial.CDL.System4.pipe ; mkfifo Buildings_11_Buildings.Examples.Tutorial.CDL.System4.pipe ; head -c 1048576 < Buildings_11_Buildings.Examples.Tutorial.CDL.System4.pipe >> ../files/Buildings_11_Buildings.Examples.Tutorial.CDL.System4.sim & ./Buildings_11_Buildings.Examples.Tutorial.CDL.System4  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_11_Buildings.Examples.Tutorial.CDL.System4.pipe 2>&1)