Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors.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.Airflow.Multizone.Examples.ClosedDoors,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|dooAB.vAB|dooAB.vBA|dooAC.vAB|dooAC.vBA|dooBC.vAB|dooBC.vBA",fileNamePrefix="Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors")
translateModel(Buildings.Airflow.Multizone.Examples.ClosedDoors,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|dooAB.vAB|dooAB.vBA|dooAC.vAB|dooAC.vBA|dooBC.vAB|dooBC.vBA",fileNamePrefix="Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001659/0.001659, allocations: 111.5 kB / 16.41 MB, free: 6.516 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.001691/0.001691, allocations: 185.3 kB / 17.34 MB, free: 5.738 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.571/1.571, allocations: 222.9 MB / 241 MB, free: 15.14 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.727/2.727, allocations: 437.1 MB / 0.7112 GB, free: 4.379 MB / 0.5762 GB
Notification: Performance of FrontEnd - loaded program: time 0.002068/0.002068, allocations: 64.12 kB / 1.019 GB, free: 9.41 MB / 0.795 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.143/1.145, allocations: 151.6 MB / 1.167 GB, free: 3.84 MB / 0.8887 GB
Notification: Performance of NFInst.instantiate(Buildings.Airflow.Multizone.Examples.ClosedDoors): time 0.2859/1.431, allocations: 218.5 MB / 1.381 GB, free: 8.473 MB / 1.107 GB
Notification: Performance of NFInst.instExpressions: time 0.03227/1.463, allocations: 20.43 MB / 1.401 GB, free: 3.984 MB / 1.123 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003743/1.467, allocations: 59.69 kB / 1.401 GB, free: 3.926 MB / 1.123 GB
Notification: Performance of NFTyping.typeComponents: time 0.004419/1.472, allocations: 1.317 MB / 1.402 GB, free: 2.602 MB / 1.123 GB
Notification: Performance of NFTyping.typeBindings: time 0.01403/1.486, allocations: 4.202 MB / 1.406 GB, free: 14.38 MB / 1.139 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005644/1.491, allocations: 1.546 MB / 1.408 GB, free: 12.84 MB / 1.139 GB
Notification: Performance of NFFlatten.flatten: time 0.01194/1.503, allocations: 6.976 MB / 1.414 GB, free: 5.84 MB / 1.139 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.005374/1.509, allocations: 2.36 MB / 1.417 GB, free: 3.438 MB / 1.139 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006509/1.515, allocations: 2.43 MB / 1.419 GB, free: 1 MB / 1.139 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00663/1.522, allocations: 2.45 MB / 1.421 GB, free: 14.55 MB / 1.154 GB
Notification: Performance of NFPackage.collectConstants: time 0.001646/1.524, allocations: 344 kB / 1.422 GB, free: 14.21 MB / 1.154 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0103/1.534, allocations: 3.492 MB / 1.425 GB, free: 10.71 MB / 1.154 GB
Notification: Performance of NFScalarize.scalarize: time 0.003264/1.537, allocations: 1.461 MB / 1.427 GB, free: 9.25 MB / 1.154 GB
Notification: Performance of NFVerifyModel.verify: time 0.005856/1.543, allocations: 1.859 MB / 1.428 GB, free: 7.383 MB / 1.154 GB
Notification: Performance of NFConvertDAE.convert: time 0.01753/1.561, allocations: 5.786 MB / 1.434 GB, free: 1.582 MB / 1.154 GB
Notification: Performance of FrontEnd - DAE generated: time 1.116e-05/1.561, allocations: 0 / 1.434 GB, free: 1.582 MB / 1.154 GB
Notification: Performance of FrontEnd: time 6.642e-06/1.561, allocations: 4 kB / 1.434 GB, free: 1.578 MB / 1.154 GB
Notification: Performance of Transformations before backend: time 0.0003061/1.561, allocations: 0 / 1.434 GB, free: 1.578 MB / 1.154 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 697
 * Number of variables: 697
Notification: Performance of Generate backend data structure: time 0.01672/1.578, allocations: 4.04 MB / 1.438 GB, free: 13.47 MB / 1.17 GB
Notification: Performance of prepare preOptimizeDAE: time 5.434e-05/1.578, allocations: 12.03 kB / 1.438 GB, free: 13.46 MB / 1.17 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005985/1.584, allocations: 0.8448 MB / 1.439 GB, free: 12.61 MB / 1.17 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005771/1.59, allocations: 1.943 MB / 1.441 GB, free: 10.61 MB / 1.17 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002824/1.59, allocations: 197.4 kB / 1.441 GB, free: 10.41 MB / 1.17 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001145/1.591, allocations: 271.9 kB / 1.441 GB, free: 10.15 MB / 1.17 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.009543/1.601, allocations: 3.287 MB / 1.444 GB, free: 6.82 MB / 1.17 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001165/1.601, allocations: 0 / 1.444 GB, free: 6.82 MB / 1.17 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007677/1.602, allocations: 108 kB / 1.445 GB, free: 6.715 MB / 1.17 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001878/1.602, allocations: 133.4 kB / 1.445 GB, free: 6.582 MB / 1.17 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01013/1.612, allocations: 4.619 MB / 1.449 GB, free: 1.949 MB / 1.17 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.02445/1.637, allocations: 10.94 MB / 1.46 GB, free: 6.328 MB / 1.186 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.008589/1.645, allocations: 4.85 MB / 1.465 GB, free: 1.441 MB / 1.186 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005018/1.65, allocations: 2.536 MB / 1.467 GB, free: 14.9 MB / 1.201 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001447/1.652, allocations: 0.8603 MB / 1.468 GB, free: 13.88 MB / 1.201 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001067/1.652, allocations: 81.64 kB / 1.468 GB, free: 13.79 MB / 1.201 GB
Notification: Performance of pre-optimization done (n=399): time 8.596e-06/1.652, allocations: 0 / 1.468 GB, free: 13.79 MB / 1.201 GB
Notification: Performance of matching and sorting (n=399): time 0.01365/1.666, allocations: 6.032 MB / 1.474 GB, free: 7.668 MB / 1.201 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.877e-05/1.666, allocations: 94.55 kB / 1.474 GB, free: 7.562 MB / 1.201 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002642/1.668, allocations: 1.236 MB / 1.475 GB, free: 6.32 MB / 1.201 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004429/1.669, allocations: 93.7 kB / 1.475 GB, free: 6.223 MB / 1.201 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008311/1.67, allocations: 0.8229 MB / 1.476 GB, free: 5.391 MB / 1.201 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001831/1.672, allocations: 1.398 MB / 1.477 GB, free: 3.98 MB / 1.201 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001418/1.673, allocations: 0.5469 MB / 1.478 GB, free: 3.426 MB / 1.201 GB
Notification: Performance of setup shared object (initialization): time 0.0001546/1.673, allocations: 309.1 kB / 1.478 GB, free: 3.121 MB / 1.201 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003233/1.676, allocations: 1.599 MB / 1.48 GB, free: 1.52 MB / 1.201 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003561/1.68, allocations: 1.913 MB / 1.482 GB, free: 15.56 MB / 1.217 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007138/1.687, allocations: 3.838 MB / 1.485 GB, free: 11.66 MB / 1.217 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.413e-05/1.687, allocations: 0 / 1.485 GB, free: 11.66 MB / 1.217 GB
Notification: Performance of matching and sorting (n=430) (initialization): time 0.008517/1.696, allocations: 4.212 MB / 1.49 GB, free: 7.43 MB / 1.217 GB
Notification: Performance of prepare postOptimizeDAE: time 4.195e-05/1.696, allocations: 10.5 kB / 1.49 GB, free: 7.422 MB / 1.217 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.934e-05/1.696, allocations: 7.938 kB / 1.49 GB, free: 7.414 MB / 1.217 GB
Notification: Performance of postOpt tearingSystem (initialization): time 5.63e-05/1.696, allocations: 16 kB / 1.49 GB, free: 7.398 MB / 1.217 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003122/1.699, allocations: 0.6788 MB / 1.49 GB, free: 6.719 MB / 1.217 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 7.924e-05/1.699, allocations: 24.3 kB / 1.49 GB, free: 6.695 MB / 1.217 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002721/1.702, allocations: 250.1 kB / 1.491 GB, free: 6.449 MB / 1.217 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003335/1.702, allocations: 116 kB / 1.491 GB, free: 6.336 MB / 1.217 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 14
 * 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 (430):
 * Single equations (assignments): 430
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.001743/1.704, allocations: 0.7196 MB / 1.491 GB, free: 5.605 MB / 1.217 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001019/1.705, allocations: 258.4 kB / 1.492 GB, free: 5.352 MB / 1.217 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.009989/1.715, allocations: 4.638 MB / 1.496 GB, free: 0.668 MB / 1.217 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.142e-05/1.715, allocations: 36 kB / 1.496 GB, free: 0.6328 MB / 1.217 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.257e-05/1.715, allocations: 4 kB / 1.496 GB, free: 0.6289 MB / 1.217 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.007494/1.723, allocations: 3.958 MB / 1.5 GB, free: 12.61 MB / 1.232 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01751/1.74, allocations: 8.274 MB / 1.508 GB, free: 4.254 MB / 1.232 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.346e-05/1.74, allocations: 4 kB / 1.508 GB, free: 4.25 MB / 1.232 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003325/1.744, allocations: 0.6553 MB / 1.509 GB, free: 3.594 MB / 1.232 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0006194/1.744, allocations: 150.4 kB / 1.509 GB, free: 3.438 MB / 1.232 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0003931/1.745, allocations: 83.97 kB / 1.509 GB, free: 3.355 MB / 1.232 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005513/1.75, allocations: 5.032 MB / 1.514 GB, free: 13.91 MB / 1.248 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.552e-06/1.75, allocations: 3.938 kB / 1.514 GB, free: 13.9 MB / 1.248 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01513/1.765, allocations: 6.837 MB / 1.521 GB, free: 7.008 MB / 1.248 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00246/1.768, allocations: 0.7719 MB / 1.521 GB, free: 6.215 MB / 1.248 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0009189/1.769, allocations: 68 kB / 1.521 GB, free: 6.148 MB / 1.248 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002843/1.772, allocations: 90 kB / 1.521 GB, free: 6.062 MB / 1.248 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0007388/1.772, allocations: 222.8 kB / 1.522 GB, free: 5.844 MB / 1.248 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004657/1.773, allocations: 112 kB / 1.522 GB, free: 5.734 MB / 1.248 GB
Notification: Performance of sorting global known variables: time 0.002076/1.775, allocations: 0.8645 MB / 1.523 GB, free: 4.867 MB / 1.248 GB
Notification: Performance of sort global known variables: time 2.41e-07/1.775, allocations: 0 / 1.523 GB, free: 4.867 MB / 1.248 GB
Notification: Performance of remove unused functions: time 0.004341/1.779, allocations: 1.069 MB / 1.524 GB, free: 3.797 MB / 1.248 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 15 (dooAB.mExcAB,dooAB.mExcBA,volA.dynBal.medium.Xi[1],volA.dynBal.U,volA.dynBal.m,volB.dynBal.medium.Xi[1],volB.dynBal.U,volB.dynBal.m,volC.dynBal.medium.Xi[1],volC.dynBal.U,volC.dynBal.m,dooAC.mExcAB,dooAC.mExcBA,dooBC.mExcAB,dooBC.mExcBA)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (393):
 * Single equations (assignments): 390
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 3 systems
   {(1,2,100.0%), (1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.001174/1.781, allocations: 352.2 kB / 1.524 GB, free: 3.441 MB / 1.248 GB
Notification: Performance of simCode: created initialization part: time 0.008777/1.789, allocations: 4.059 MB / 1.528 GB, free: 15.37 MB / 1.264 GB
Notification: Performance of simCode: created event and clocks part: time 8.536e-06/1.789, allocations: 0 / 1.528 GB, free: 15.37 MB / 1.264 GB
Notification: Performance of simCode: created simulation system equations: time 0.005388/1.795, allocations: 2.56 MB / 1.53 GB, free: 12.77 MB / 1.264 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00687/1.802, allocations: 1.074 MB / 1.532 GB, free: 11.71 MB / 1.264 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01463/1.816, allocations: 6.685 MB / 1.538 GB, free: 4.973 MB / 1.264 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002827/1.819, allocations: 1.939 MB / 1.54 GB, free: 2.996 MB / 1.264 GB
Notification: Performance of simCode: alias equations: time 0.005552/1.825, allocations: 1.219 MB / 1.541 GB, free: 1.77 MB / 1.264 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001763/1.827, allocations: 239.4 kB / 1.541 GB, free: 1.535 MB / 1.264 GB
Notification: Performance of SimCode: time 1.162e-06/1.827, allocations: 0 / 1.541 GB, free: 1.535 MB / 1.264 GB
Notification: Performance of Templates: time 0.877/2.704, allocations: 48.6 MB / 1.589 GB, free: 363.3 MB / 1.279 GB
make -j1 -f Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors.makefile
(rm -f Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors.pipe ; mkfifo Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors.pipe ; head -c 1048576 < Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors.pipe >> ../files/Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors.sim & ./Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors  -abortSlowSimulation -alarm=480 -s cvode -emit_protected -lv LOG_STATS > Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors.pipe 2>&1)
diffSimulationResults("Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_10.0.x/Buildings_Airflow_Multizone_Examples_ClosedDoors.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_10_Buildings.Airflow.Multizone.Examples.ClosedDoors.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches