Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed.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 9.1.3-maint.9.1.x/package.mo", uses=false)
Using package Buildings with version 9.1.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.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.Validation.DoorOpenClosed,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|doo.port_a1.m_flow|doo.port_b2.m_flow|dooOpeClo.port_a1.m_flow|dooOpeClo.port_b2.m_flow|lea.port_a.m_flow|mNetClo_flow.y",fileNamePrefix="Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed")
translateModel(Buildings.Airflow.Multizone.Validation.DoorOpenClosed,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|doo.port_a1.m_flow|doo.port_b2.m_flow|dooOpeClo.port_a1.m_flow|dooOpeClo.port_b2.m_flow|lea.port_a.m_flow|mNetClo_flow.y",fileNamePrefix="Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001299/0.001299, allocations: 111.3 kB / 15.23 MB, free: 0.6406 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.001578/0.001578, allocations: 192.4 kB / 16.14 MB, free: 6.711 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.36/1.36, allocations: 222.9 MB / 239.8 MB, free: 4.617 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.x/package.mo): time 2.379/2.379, allocations: 390.2 MB / 0.6642 GB, free: 0.6172 MB / 0.5137 GB
Notification: Performance of FrontEnd - loaded program: time 0.001852/0.001852, allocations: 59.89 kB / 0.8118 GB, free: 14.87 MB / 0.67 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5811/0.583, allocations: 140.3 MB / 0.9489 GB, free: 9.137 MB / 0.7169 GB
Notification: Performance of NFInst.instantiate(Buildings.Airflow.Multizone.Validation.DoorOpenClosed): time 0.2005/0.7836, allocations: 196.4 MB / 1.141 GB, free: 12.98 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.01282/0.7964, allocations: 9.506 MB / 1.15 GB, free: 3.445 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001422/0.7979, allocations: 15.94 kB / 1.15 GB, free: 3.43 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 0.00197/0.7999, allocations: 0.5248 MB / 1.151 GB, free: 2.902 MB / 0.9044 GB
Notification: Performance of NFTyping.typeBindings: time 0.00489/0.8049, allocations: 1.902 MB / 1.152 GB, free: 0.9961 MB / 0.9044 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0023/0.8072, allocations: 0.6538 MB / 1.153 GB, free: 352 kB / 0.9044 GB
Notification: Performance of NFFlatten.flatten: time 0.003518/0.8107, allocations: 3.182 MB / 1.156 GB, free: 13.15 MB / 0.92 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001201/0.8119, allocations: 0.6349 MB / 1.157 GB, free: 12.5 MB / 0.92 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002766/0.8147, allocations: 1.261 MB / 1.158 GB, free: 11.24 MB / 0.92 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001309/0.816, allocations: 0.7666 MB / 1.159 GB, free: 10.47 MB / 0.92 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001937/0.8162, allocations: 52 kB / 1.159 GB, free: 10.42 MB / 0.92 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003933/0.8202, allocations: 2.233 MB / 1.161 GB, free: 8.18 MB / 0.92 GB
Notification: Performance of NFScalarize.scalarize: time 0.0004748/0.8207, allocations: 331 kB / 1.161 GB, free: 7.855 MB / 0.92 GB
Notification: Performance of NFVerifyModel.verify: time 0.0008071/0.8215, allocations: 489.6 kB / 1.162 GB, free: 7.375 MB / 0.92 GB
Notification: Performance of NFConvertDAE.convert: time 0.003268/0.8248, allocations: 1.94 MB / 1.164 GB, free: 5.43 MB / 0.92 GB
Notification: Performance of FrontEnd - DAE generated: time 3.727e-06/0.8248, allocations: 4 kB / 1.164 GB, free: 5.426 MB / 0.92 GB
Notification: Performance of FrontEnd: time 1.232e-06/0.8248, allocations: 0 / 1.164 GB, free: 5.426 MB / 0.92 GB
Notification: Performance of Transformations before backend: time 2.52e-05/0.8248, allocations: 0 / 1.164 GB, free: 5.426 MB / 0.92 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 185
 * Number of variables: 185
Notification: Performance of Generate backend data structure: time 0.003808/0.8286, allocations: 1.426 MB / 1.165 GB, free: 3.945 MB / 0.92 GB
Notification: Performance of prepare preOptimizeDAE: time 4.431e-05/0.8287, allocations: 8.031 kB / 1.165 GB, free: 3.938 MB / 0.92 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0007288/0.8294, allocations: 158.7 kB / 1.165 GB, free: 3.781 MB / 0.92 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.000959/0.8304, allocations: 0.5604 MB / 1.166 GB, free: 3.176 MB / 0.92 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.17e-05/0.8305, allocations: 50 kB / 1.166 GB, free: 3.129 MB / 0.92 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001082/0.8306, allocations: 75.97 kB / 1.166 GB, free: 3.055 MB / 0.92 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001456/0.832, allocations: 0.8626 MB / 1.167 GB, free: 2.168 MB / 0.92 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.89e-05/0.8321, allocations: 3.938 kB / 1.167 GB, free: 2.164 MB / 0.92 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 6.295e-05/0.8321, allocations: 24 kB / 1.167 GB, free: 2.141 MB / 0.92 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.67e-05/0.8322, allocations: 49.98 kB / 1.167 GB, free: 2.094 MB / 0.92 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001357/0.8336, allocations: 0.7651 MB / 1.168 GB, free: 1.324 MB / 0.92 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.005283/0.8389, allocations: 4.522 MB / 1.172 GB, free: 12.26 MB / 0.9356 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0007619/0.8396, allocations: 417.3 kB / 1.172 GB, free: 11.85 MB / 0.9356 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003199/0.84, allocations: 193.4 kB / 1.173 GB, free: 11.66 MB / 0.9356 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0006834/0.8407, allocations: 0.7638 MB / 1.173 GB, free: 10.73 MB / 0.9356 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.835e-05/0.8407, allocations: 38.89 kB / 1.173 GB, free: 10.68 MB / 0.9356 GB
Notification: Performance of pre-optimization done (n=40): time 2.154e-06/0.8407, allocations: 0 / 1.173 GB, free: 10.68 MB / 0.9356 GB
Notification: Performance of matching and sorting (n=40): time 0.001295/0.842, allocations: 0.6063 MB / 1.174 GB, free: 10.07 MB / 0.9356 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.423e-05/0.8421, allocations: 59.34 kB / 1.174 GB, free: 9.996 MB / 0.9356 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001076/0.8431, allocations: 0.8603 MB / 1.175 GB, free: 9.129 MB / 0.9356 GB
Notification: Performance of collectPreVariables (initialization): time 4.042e-05/0.8432, allocations: 37.7 kB / 1.175 GB, free: 9.086 MB / 0.9356 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002786/0.8435, allocations: 387.6 kB / 1.175 GB, free: 8.699 MB / 0.9356 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001046/0.8436, allocations: 141.9 kB / 1.175 GB, free: 8.559 MB / 0.9356 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001694/0.8438, allocations: 98.16 kB / 1.175 GB, free: 8.457 MB / 0.9356 GB
Notification: Performance of setup shared object (initialization): time 0.0001067/0.8439, allocations: 330 kB / 1.176 GB, free: 8.129 MB / 0.9356 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000344/0.8442, allocations: 181 kB / 1.176 GB, free: 7.949 MB / 0.9356 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.000411/0.8446, allocations: 281.5 kB / 1.176 GB, free: 7.648 MB / 0.9356 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0007048/0.8454, allocations: 450.6 kB / 1.177 GB, free: 7.18 MB / 0.9356 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.268e-06/0.8454, allocations: 4 kB / 1.177 GB, free: 7.176 MB / 0.9356 GB
Notification: Performance of matching and sorting (n=57) (initialization): time 0.001028/0.8464, allocations: 0.578 MB / 1.177 GB, free: 6.59 MB / 0.9356 GB
Notification: Performance of prepare postOptimizeDAE: time 1.809e-05/0.8464, allocations: 8 kB / 1.177 GB, free: 6.582 MB / 0.9356 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.712e-06/0.8465, allocations: 0 / 1.177 GB, free: 6.582 MB / 0.9356 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.481e-05/0.8465, allocations: 4 kB / 1.177 GB, free: 6.578 MB / 0.9356 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005171/0.847, allocations: 116 kB / 1.177 GB, free: 6.465 MB / 0.9356 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.075e-05/0.847, allocations: 4 kB / 1.177 GB, free: 6.461 MB / 0.9356 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006964/0.8477, allocations: 103.1 kB / 1.177 GB, free: 6.359 MB / 0.9356 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.135e-05/0.8478, allocations: 20 kB / 1.177 GB, free: 6.34 MB / 0.9356 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 9
 * 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 (57):
 * Single equations (assignments): 57
 * 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.0003/0.8481, allocations: 237.7 kB / 1.178 GB, free: 6.098 MB / 0.9356 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001261/0.8482, allocations: 83 kB / 1.178 GB, free: 6.016 MB / 0.9356 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001007/0.8492, allocations: 0.5592 MB / 1.178 GB, free: 5.445 MB / 0.9356 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.015e-06/0.8493, allocations: 7.938 kB / 1.178 GB, free: 5.438 MB / 0.9356 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.31e-06/0.8493, allocations: 0 / 1.178 GB, free: 5.438 MB / 0.9356 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.213e-06/0.8493, allocations: 3.984 kB / 1.178 GB, free: 5.434 MB / 0.9356 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003297/0.8526, allocations: 2.12 MB / 1.18 GB, free: 3.141 MB / 0.9356 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.438e-06/0.8526, allocations: 4 kB / 1.18 GB, free: 3.137 MB / 0.9356 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004232/0.853, allocations: 95.83 kB / 1.18 GB, free: 3.043 MB / 0.9356 GB
Notification: Performance of postOpt tearingSystem (simulation): time 8.626e-06/0.853, allocations: 8 kB / 1.18 GB, free: 3.035 MB / 0.9356 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.663e-05/0.8531, allocations: 12 kB / 1.18 GB, free: 3.023 MB / 0.9356 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.817e-05/0.8531, allocations: 12.44 kB / 1.181 GB, free: 3.012 MB / 0.9356 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.831e-06/0.8531, allocations: 8 kB / 1.181 GB, free: 3.004 MB / 0.9356 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001315/0.8544, allocations: 0.9928 MB / 1.181 GB, free: 1.914 MB / 0.9356 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003235/0.8548, allocations: 211.9 kB / 1.182 GB, free: 1.688 MB / 0.9356 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001392/0.8549, allocations: 19.92 kB / 1.182 GB, free: 1.668 MB / 0.9356 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006169/0.8556, allocations: 44.03 kB / 1.182 GB, free: 1.625 MB / 0.9356 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.299e-05/0.8557, allocations: 47.83 kB / 1.182 GB, free: 1.578 MB / 0.9356 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 3.698e-05/0.8557, allocations: 27.94 kB / 1.182 GB, free: 1.551 MB / 0.9356 GB
Notification: Performance of sorting global known variables: time 0.0007822/0.8565, allocations: 0.6278 MB / 1.182 GB, free: 0.9297 MB / 0.9356 GB
Notification: Performance of sort global known variables: time 1.31e-07/0.8565, allocations: 0 / 1.182 GB, free: 0.9297 MB / 0.9356 GB
Notification: Performance of remove unused functions: time 0.0007387/0.8573, allocations: 239.7 kB / 1.183 GB, free: 0.6953 MB / 0.9356 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 27
 * Number of states: 1 (lea.mExc)
 * 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 (48):
 * Single equations (assignments): 48
 * 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 Backend phase and start with SimCode phase: time 0.0004595/0.8577, allocations: 242.4 kB / 1.183 GB, free: 468 kB / 0.9356 GB
Notification: Performance of simCode: created initialization part: time 0.0008422/0.8586, allocations: 446.3 kB / 1.183 GB, free: 24 kB / 0.9356 GB
Notification: Performance of simCode: created event and clocks part: time 5.09e-06/0.8586, allocations: 4 kB / 1.183 GB, free: 20 kB / 0.9356 GB
Notification: Performance of simCode: created simulation system equations: time 0.00043/0.859, allocations: 229.6 kB / 1.184 GB, free: 15.8 MB / 0.9512 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002274/0.8613, allocations: 494.5 kB / 1.184 GB, free: 15.32 MB / 0.9512 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002493/0.8638, allocations: 1.833 MB / 1.186 GB, free: 13.38 MB / 0.9512 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005793/0.8644, allocations: 1.012 MB / 1.187 GB, free: 12.33 MB / 0.9512 GB
Notification: Performance of simCode: alias equations: time 0.0007352/0.8652, allocations: 179.1 kB / 1.187 GB, free: 12.15 MB / 0.9512 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002094/0.8654, allocations: 67.42 kB / 1.187 GB, free: 12.09 MB / 0.9512 GB
Notification: Performance of SimCode: time 4.51e-07/0.8654, allocations: 4 kB / 1.187 GB, free: 12.08 MB / 0.9512 GB
Notification: Performance of Templates: time 0.02764/0.893, allocations: 16.41 MB / 1.203 GB, free: 11.88 MB / 0.9669 GB
make -j1 -f Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed.makefile
(rm -f Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed.pipe ; mkfifo Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed.pipe ; head -c 1048576 < Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed.pipe >> ../files/Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed.sim & ./Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Airflow_Multizone_Validation_DoorOpenClosed.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_9_Buildings.Airflow.Multizone.Validation.DoorOpenClosed.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches