Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice.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.0.0-master/package.mo", uses=false)
Using package Buildings with version 11.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.0-master/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.Orifice,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|ori.V_flow|ori.dp|ori.v",fileNamePrefix="Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice")
translateModel(Buildings.Airflow.Multizone.Examples.Orifice,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|ori.V_flow|ori.dp|ori.v",fileNamePrefix="Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001315/0.001315, allocations: 104.8 kB / 16.36 MB, free: 5.828 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.001479/0.001479, allocations: 194.6 kB / 17.29 MB, free: 5.484 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.387/1.387, allocations: 222.9 MB / 241 MB, free: 15.15 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.0-master/package.mo): time 2.487/2.487, allocations: 442.6 MB / 0.7165 GB, free: 14.72 MB / 0.5919 GB
Notification: Performance of FrontEnd - loaded program: time 0.00135/0.00135, allocations: 60.62 kB / 0.8773 GB, free: 11.03 MB / 0.6544 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3738/0.3752, allocations: 153 MB / 1.027 GB, free: 2.105 MB / 0.795 GB
Notification: Performance of NFInst.instantiate(Buildings.Airflow.Multizone.Examples.Orifice): time 0.9436/1.319, allocations: 173.8 MB / 1.196 GB, free: 8.418 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.004544/1.323, allocations: 2.296 MB / 1.199 GB, free: 6.547 MB / 0.9044 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0006203/1.324, allocations: 16.03 kB / 1.199 GB, free: 6.539 MB / 0.9044 GB
Notification: Performance of NFTyping.typeComponents: time 0.0008507/1.325, allocations: 230.9 kB / 1.199 GB, free: 6.344 MB / 0.9044 GB
Notification: Performance of NFTyping.typeBindings: time 0.002475/1.327, allocations: 0.938 MB / 1.2 GB, free: 5.629 MB / 0.9044 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00226/1.33, allocations: 0.819 MB / 1.201 GB, free: 5.035 MB / 0.9044 GB
Notification: Performance of NFFlatten.flatten: time 0.001492/1.331, allocations: 0.9716 MB / 1.202 GB, free: 4.473 MB / 0.9044 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0005464/1.332, allocations: 333 kB / 1.202 GB, free: 4.273 MB / 0.9044 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0008218/1.333, allocations: 459.3 kB / 1.202 GB, free: 4.02 MB / 0.9044 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0004346/1.333, allocations: 311.3 kB / 1.203 GB, free: 3.836 MB / 0.9044 GB
Notification: Performance of NFPackage.collectConstants: time 5.527e-05/1.333, allocations: 33.72 kB / 1.203 GB, free: 3.836 MB / 0.9044 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002163/1.335, allocations: 0.9957 MB / 1.204 GB, free: 3.273 MB / 0.9044 GB
Notification: Performance of NFScalarize.scalarize: time 0.000189/1.336, allocations: 144.3 kB / 1.204 GB, free: 3.176 MB / 0.9044 GB
Notification: Performance of NFVerifyModel.verify: time 0.0002842/1.336, allocations: 235.3 kB / 1.204 GB, free: 3.031 MB / 0.9044 GB
Notification: Performance of NFConvertDAE.convert: time 0.001444/1.337, allocations: 0.898 MB / 1.205 GB, free: 2.492 MB / 0.9044 GB
Notification: Performance of FrontEnd - DAE generated: time 6.983e-06/1.337, allocations: 4 kB / 1.205 GB, free: 2.488 MB / 0.9044 GB
Notification: Performance of FrontEnd: time 1.923e-06/1.337, allocations: 0 / 1.205 GB, free: 2.488 MB / 0.9044 GB
Notification: Performance of Transformations before backend: time 1.09e-05/1.337, allocations: 0 / 1.205 GB, free: 2.488 MB / 0.9044 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 74
 * Number of variables: 74
Notification: Performance of Generate backend data structure: time 0.001324/1.339, allocations: 0.8093 MB / 1.206 GB, free: 1.801 MB / 0.9044 GB
Notification: Performance of prepare preOptimizeDAE: time 4.363e-05/1.339, allocations: 10.47 kB / 1.206 GB, free: 1.801 MB / 0.9044 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00132/1.34, allocations: 179.3 kB / 1.206 GB, free: 1.715 MB / 0.9044 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0007717/1.341, allocations: 396.3 kB / 1.206 GB, free: 1.363 MB / 0.9044 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 3e-05/1.341, allocations: 22.38 kB / 1.206 GB, free: 1.348 MB / 0.9044 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 6.228e-05/1.341, allocations: 29.34 kB / 1.206 GB, free: 1.34 MB / 0.9044 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0006975/1.342, allocations: 371.7 kB / 1.207 GB, free: 1.086 MB / 0.9044 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.849e-05/1.342, allocations: 0 / 1.207 GB, free: 1.086 MB / 0.9044 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.433e-05/1.342, allocations: 16.5 kB / 1.207 GB, free: 1.074 MB / 0.9044 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.248e-05/1.342, allocations: 12.36 kB / 1.207 GB, free: 1.07 MB / 0.9044 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0005216/1.342, allocations: 263.7 kB / 1.207 GB, free: 0.9453 MB / 0.9044 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.002026/1.344, allocations: 1.669 MB / 1.209 GB, free: 15.4 MB / 0.92 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0003997/1.345, allocations: 211.5 kB / 1.209 GB, free: 15.29 MB / 0.92 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0002073/1.345, allocations: 111 kB / 1.209 GB, free: 15.24 MB / 0.92 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.00107/1.346, allocations: 0.8758 MB / 1.21 GB, free: 14.25 MB / 0.92 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.513e-05/1.346, allocations: 30.56 kB / 1.21 GB, free: 14.21 MB / 0.92 GB
Notification: Performance of pre-optimization done (n=23): time 1.673e-06/1.346, allocations: 0 / 1.21 GB, free: 14.21 MB / 0.92 GB
Notification: Performance of matching and sorting (n=23): time 0.0008805/1.347, allocations: 362.3 kB / 1.21 GB, free: 14.04 MB / 0.92 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.506e-05/1.347, allocations: 57.28 kB / 1.21 GB, free: 13.97 MB / 0.92 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.000458/1.348, allocations: 419 kB / 1.211 GB, free: 13.72 MB / 0.92 GB
Notification: Performance of collectPreVariables (initialization): time 3.15e-05/1.348, allocations: 31.98 kB / 1.211 GB, free: 13.68 MB / 0.92 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001776/1.348, allocations: 212.6 kB / 1.211 GB, free: 13.49 MB / 0.92 GB
Notification: Performance of collectInitialBindings (initialization): time 6.962e-05/1.348, allocations: 87.23 kB / 1.211 GB, free: 13.42 MB / 0.92 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 9.348e-05/1.348, allocations: 53.77 kB / 1.211 GB, free: 13.38 MB / 0.92 GB
Notification: Performance of setup shared object (initialization): time 0.000182/1.348, allocations: 354.2 kB / 1.211 GB, free: 13.03 MB / 0.92 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0001852/1.348, allocations: 78.61 kB / 1.211 GB, free: 13 MB / 0.92 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0002217/1.349, allocations: 120 kB / 1.211 GB, free: 12.92 MB / 0.92 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0003964/1.349, allocations: 215.9 kB / 1.212 GB, free: 12.8 MB / 0.92 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.915e-06/1.349, allocations: 0 / 1.212 GB, free: 12.8 MB / 0.92 GB
Notification: Performance of matching and sorting (n=28) (initialization): time 0.0005276/1.349, allocations: 282.6 kB / 1.212 GB, free: 12.65 MB / 0.92 GB
Notification: Performance of prepare postOptimizeDAE: time 1.975e-05/1.35, allocations: 5.281 kB / 1.212 GB, free: 12.65 MB / 0.92 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.412e-06/1.35, allocations: 0 / 1.212 GB, free: 12.65 MB / 0.92 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.786e-05/1.35, allocations: 2.469 kB / 1.212 GB, free: 12.65 MB / 0.92 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0002329/1.35, allocations: 56.39 kB / 1.212 GB, free: 12.64 MB / 0.92 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 8.776e-06/1.35, allocations: 10.62 kB / 1.212 GB, free: 12.63 MB / 0.92 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0002294/1.35, allocations: 31.17 kB / 1.212 GB, free: 12.61 MB / 0.92 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.076e-05/1.35, allocations: 13.47 kB / 1.212 GB, free: 12.6 MB / 0.92 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 4
 * 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 (28):
 * Single equations (assignments): 28
 * 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.0001675/1.35, allocations: 168.8 kB / 1.212 GB, free: 12.45 MB / 0.92 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 7.448e-05/1.35, allocations: 43.97 kB / 1.212 GB, free: 12.43 MB / 0.92 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0005738/1.351, allocations: 283.5 kB / 1.213 GB, free: 12.27 MB / 0.92 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.45e-06/1.351, allocations: 7 kB / 1.213 GB, free: 12.26 MB / 0.92 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.714e-06/1.351, allocations: 3.984 kB / 1.213 GB, free: 12.26 MB / 0.92 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.15e-06/1.351, allocations: 3.938 kB / 1.213 GB, free: 12.25 MB / 0.92 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00128/1.352, allocations: 0.8082 MB / 1.213 GB, free: 11.61 MB / 0.92 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.747e-06/1.352, allocations: 2.156 kB / 1.213 GB, free: 11.61 MB / 0.92 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002201/1.352, allocations: 49.03 kB / 1.213 GB, free: 11.59 MB / 0.92 GB
Notification: Performance of postOpt tearingSystem (simulation): time 4.659e-06/1.352, allocations: 4.969 kB / 1.213 GB, free: 11.59 MB / 0.92 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 1.813e-05/1.353, allocations: 1.875 kB / 1.213 GB, free: 11.59 MB / 0.92 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 5.25e-06/1.353, allocations: 6.469 kB / 1.213 GB, free: 11.59 MB / 0.92 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.634e-06/1.353, allocations: 3.875 kB / 1.213 GB, free: 11.59 MB / 0.92 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0007701/1.353, allocations: 0.51 MB / 1.214 GB, free: 11.22 MB / 0.92 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001838/1.353, allocations: 144.3 kB / 1.214 GB, free: 11.08 MB / 0.92 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 5.891e-05/1.354, allocations: 10.83 kB / 1.214 GB, free: 11.07 MB / 0.92 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002561/1.354, allocations: 19.27 kB / 1.214 GB, free: 11.06 MB / 0.92 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 6.715e-05/1.354, allocations: 13.58 kB / 1.214 GB, free: 11.06 MB / 0.92 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 2.095e-05/1.354, allocations: 12.22 kB / 1.214 GB, free: 11.05 MB / 0.92 GB
Notification: Performance of sorting global known variables: time 0.0003245/1.354, allocations: 300.2 kB / 1.214 GB, free: 10.87 MB / 0.92 GB
Notification: Performance of sort global known variables: time 2.91e-07/1.354, allocations: 0 / 1.214 GB, free: 10.87 MB / 0.92 GB
Notification: Performance of remove unused functions: time 0.0004752/1.355, allocations: 124.6 kB / 1.214 GB, free: 10.84 MB / 0.92 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 7
 * Number of states: 3 (ori.mExc,den1.d,den2.d)
 * 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 (23):
 * Single equations (assignments): 23
 * 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.000459/1.355, allocations: 194.3 kB / 1.215 GB, free: 10.7 MB / 0.92 GB
Notification: Performance of simCode: created initialization part: time 0.0004892/1.356, allocations: 208.1 kB / 1.215 GB, free: 10.61 MB / 0.92 GB
Notification: Performance of simCode: created event and clocks part: time 4.018e-06/1.356, allocations: 2.875 kB / 1.215 GB, free: 10.61 MB / 0.92 GB
Notification: Performance of simCode: created simulation system equations: time 0.0002228/1.356, allocations: 112.6 kB / 1.215 GB, free: 10.57 MB / 0.92 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001086/1.357, allocations: 223.3 kB / 1.215 GB, free: 10.45 MB / 0.92 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.001562/1.359, allocations: 0.8887 MB / 1.216 GB, free: 9.832 MB / 0.92 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000436/1.359, allocations: 0.8356 MB / 1.217 GB, free: 9.059 MB / 0.92 GB
Notification: Performance of simCode: alias equations: time 0.0002449/1.359, allocations: 92.59 kB / 1.217 GB, free: 9.012 MB / 0.92 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 7.868e-05/1.359, allocations: 32.62 kB / 1.217 GB, free: 9.008 MB / 0.92 GB
Notification: Performance of SimCode: time 2.31e-07/1.359, allocations: 0 / 1.217 GB, free: 9.008 MB / 0.92 GB
Notification: Performance of Templates: time 0.01397/1.373, allocations: 8.038 MB / 1.225 GB, free: 2.086 MB / 0.92 GB
make -j1 -f Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice.makefile
(rm -f Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice.pipe ; mkfifo Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice.pipe ; head -c 1048576 < Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice.pipe >> ../files/Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice.sim & ./Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice  -abortSlowSimulation -alarm=480 -s cvode -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Airflow_Multizone_Examples_Orifice.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Airflow.Multizone.Examples.Orifice.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches