Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001705/0.001705, allocations: 99.64 kB / 18.95 MB, free: 2.668 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001653/0.001653, allocations: 214.4 kB / 22.24 MB, free: 5.262 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.716/1.716, allocations: 230.6 MB / 256 MB, free: 7.785 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 3.722/3.722, allocations: 0.5107 GB / 0.8158 GB, free: 17.8 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 13.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Buildings.Airflow.Multizone.Examples.CO2TransportStep,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|CO2SenWes.C|CO2SenEas.C|CO2SenTop.C",fileNamePrefix="Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep")
translateModel(Buildings.Airflow.Multizone.Examples.CO2TransportStep,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|CO2SenWes.C|CO2SenEas.C|CO2SenTop.C",fileNamePrefix="Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep") [Timeout 300]
"Notification: Buildings requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.003021/0.003021, allocations: 67.67 kB / 1.186 GB, free: 13.39 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5149/0.5179, allocations: 181.9 MB / 1.364 GB, free: 13.52 MB / 1.061 GB
Notification: Performance of NFInst.instantiate(Buildings.Airflow.Multizone.Examples.CO2TransportStep): time 1.706/2.224, allocations: 262.3 MB / 1.62 GB, free: 4.277 MB / 1.295 GB
Notification: Performance of NFInst.instExpressions: time 0.04948/2.273, allocations: 21.51 MB / 1.641 GB, free: 4.203 MB / 1.295 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.006983/2.28, allocations: 104.9 kB / 1.641 GB, free: 4.203 MB / 1.295 GB
Notification: Performance of NFTyping.typeComponents: time 0.008139/2.288, allocations: 1.704 MB / 1.643 GB, free: 4.176 MB / 1.295 GB
Notification: Performance of NFTyping.typeBindings: time 0.02885/2.317, allocations: 6.45 MB / 1.649 GB, free: 3.941 MB / 1.295 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01482/2.332, allocations: 2.969 MB / 1.652 GB, free: 3.867 MB / 1.295 GB
Notification: Performance of NFFlatten.flatten: time 0.01917/2.351, allocations: 7.428 MB / 1.659 GB, free: 3.855 MB / 1.295 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00667/2.358, allocations: 2.152 MB / 1.661 GB, free: 3.703 MB / 1.295 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01442/2.372, allocations: 3.298 MB / 1.665 GB, free: 3.688 MB / 1.295 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01023/2.382, allocations: 2.743 MB / 1.667 GB, free: 3.684 MB / 1.295 GB
Notification: Performance of NFPackage.collectConstants: time 0.002826/2.385, allocations: 348.1 kB / 1.668 GB, free: 3.684 MB / 1.295 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02351/2.409, allocations: 4.937 MB / 1.672 GB, free: 3.625 MB / 1.295 GB
Notification: Performance of NFScalarize.scalarize: time 0.005325/2.414, allocations: 1.511 MB / 1.674 GB, free: 3.625 MB / 1.295 GB
Notification: Performance of NFVerifyModel.verify: time 0.008655/2.423, allocations: 1.619 MB / 1.675 GB, free: 3.355 MB / 1.295 GB
Notification: Performance of NFConvertDAE.convert: time 0.02391/2.447, allocations: 6.855 MB / 1.682 GB, free: 2.57 MB / 1.295 GB
Notification: Performance of FrontEnd - DAE generated: time 7.674e-06/2.447, allocations: 0 / 1.682 GB, free: 2.57 MB / 1.295 GB
Notification: Performance of FrontEnd: time 3.106e-06/2.447, allocations: 0.9688 kB / 1.682 GB, free: 2.57 MB / 1.295 GB
Notification: Performance of Transformations before backend: time 0.0002168/2.447, allocations: 0 / 1.682 GB, free: 2.57 MB / 1.295 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 709
 * Number of variables: 709
Notification: Performance of Generate backend data structure: time 0.01606/2.463, allocations: 4.149 MB / 1.686 GB, free: 0.8633 MB / 1.295 GB
Notification: Performance of prepare preOptimizeDAE: time 5.16e-05/2.463, allocations: 9.094 kB / 1.686 GB, free: 0.8633 MB / 1.295 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009412/2.472, allocations: 1.242 MB / 1.687 GB, free: 0.6758 MB / 1.295 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.007481/2.48, allocations: 1.813 MB / 1.689 GB, free: 204 kB / 1.295 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003714/2.48, allocations: 209.2 kB / 1.689 GB, free: 196 kB / 1.295 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001757/2.482, allocations: 277.2 kB / 1.69 GB, free: 192 kB / 1.295 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01115/2.493, allocations: 4.113 MB / 1.694 GB, free: 15.42 MB / 1.311 GB
Notification: Performance of preOpt findStateOrder (simulation): time 8.602e-05/2.493, allocations: 5.844 kB / 1.694 GB, free: 15.42 MB / 1.311 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003593/2.494, allocations: 117.5 kB / 1.694 GB, free: 15.42 MB / 1.311 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002157/2.494, allocations: 146.2 kB / 1.694 GB, free: 15.41 MB / 1.311 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.008129/2.502, allocations: 3.568 MB / 1.697 GB, free: 15.38 MB / 1.311 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.02004/2.522, allocations: 8.988 MB / 1.706 GB, free: 12.45 MB / 1.311 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005261/2.527, allocations: 2.385 MB / 1.708 GB, free: 12.39 MB / 1.311 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00258/2.53, allocations: 1.401 MB / 1.71 GB, free: 12.37 MB / 1.311 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.000276/2.53, allocations: 53.91 kB / 1.71 GB, free: 12.36 MB / 1.311 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002871/2.533, allocations: 1.735 MB / 1.712 GB, free: 11.88 MB / 1.311 GB
Notification: Performance of pre-optimization done (n=213): time 4.429e-06/2.533, allocations: 0 / 1.712 GB, free: 11.88 MB / 1.311 GB
Notification: Performance of matching and sorting (n=213): time 0.00774/2.541, allocations: 3.59 MB / 1.715 GB, free: 11.68 MB / 1.311 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.62e-05/2.541, allocations: 78.73 kB / 1.715 GB, free: 11.62 MB / 1.311 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002241/2.543, allocations: 1.253 MB / 1.716 GB, free: 11.44 MB / 1.311 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003095/2.543, allocations: 77.58 kB / 1.716 GB, free: 11.4 MB / 1.311 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00132/2.545, allocations: 1.144 MB / 1.718 GB, free: 10.53 MB / 1.311 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001093/2.546, allocations: 0.7667 MB / 1.718 GB, free: 9.93 MB / 1.311 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0007306/2.546, allocations: 370.4 kB / 1.719 GB, free: 9.762 MB / 1.311 GB
Notification: Performance of setup shared object (initialization): time 0.000174/2.547, allocations: 301.1 kB / 1.719 GB, free: 9.465 MB / 1.311 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002275/2.549, allocations: 1.096 MB / 1.72 GB, free: 9.051 MB / 1.311 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002824/2.552, allocations: 1.553 MB / 1.722 GB, free: 8.141 MB / 1.311 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005268/2.557, allocations: 2.584 MB / 1.724 GB, free: 6.883 MB / 1.311 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.286e-05/2.557, allocations: 2.875 kB / 1.724 GB, free: 6.883 MB / 1.311 GB
Notification: Performance of matching and sorting (n=259) (initialization): time 0.006813/2.564, allocations: 2.915 MB / 1.727 GB, free: 5.746 MB / 1.311 GB
Notification: Performance of prepare postOptimizeDAE: time 8.82e-05/2.564, allocations: 40.33 kB / 1.727 GB, free: 5.711 MB / 1.311 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.706e-05/2.564, allocations: 7.438 kB / 1.727 GB, free: 5.711 MB / 1.311 GB
Notification: Performance of postOpt tearingSystem (initialization): time 5.196e-05/2.564, allocations: 17.66 kB / 1.727 GB, free: 5.711 MB / 1.311 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002575/2.567, allocations: 0.502 MB / 1.727 GB, free: 5.688 MB / 1.311 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.469e-05/2.567, allocations: 19.19 kB / 1.728 GB, free: 5.688 MB / 1.311 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003439/2.57, allocations: 206.6 kB / 1.728 GB, free: 5.57 MB / 1.311 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002117/2.57, allocations: 82.03 kB / 1.728 GB, free: 5.555 MB / 1.311 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 33
 * Number of states: 0 ()
 * Number of discrete variables: 5 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (258):
 * Single equations (assignments): 257
 * Array equations: 0
 * Algorithm blocks: 1
 * 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.002026/2.572, allocations: 0.6886 MB / 1.728 GB, free: 5.191 MB / 1.311 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000729/2.573, allocations: 212.6 kB / 1.729 GB, free: 5.082 MB / 1.311 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006212/2.579, allocations: 2.794 MB / 1.731 GB, free: 3.969 MB / 1.311 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.14e-05/2.579, allocations: 20.53 kB / 1.731 GB, free: 3.969 MB / 1.311 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.164e-05/2.579, allocations: 64 / 1.731 GB, free: 3.969 MB / 1.311 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004963/2.584, allocations: 2.64 MB / 1.734 GB, free: 2.77 MB / 1.311 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01204/2.596, allocations: 5.295 MB / 1.739 GB, free: 0.5586 MB / 1.311 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.189e-05/2.596, allocations: 2.469 kB / 1.739 GB, free: 0.5586 MB / 1.311 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002752/2.599, allocations: 0.5047 MB / 1.74 GB, free: 0.5391 MB / 1.311 GB
Notification: Performance of postOpt tearingSystem (simulation): time 2.515e-05/2.599, allocations: 16 kB / 1.74 GB, free: 0.5352 MB / 1.311 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001932/2.599, allocations: 56.53 kB / 1.74 GB, free: 0.5039 MB / 1.311 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.345e-05/2.599, allocations: 12.95 kB / 1.74 GB, free: 0.5039 MB / 1.311 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.102e-06/2.599, allocations: 5.281 kB / 1.74 GB, free: 0.5039 MB / 1.311 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.008972/2.608, allocations: 4.337 MB / 1.744 GB, free: 14.51 MB / 1.326 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002189/2.61, allocations: 490 kB / 1.744 GB, free: 14.18 MB / 1.326 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000411/2.611, allocations: 49.94 kB / 1.744 GB, free: 14.14 MB / 1.326 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001819/2.613, allocations: 100.4 kB / 1.745 GB, free: 14.09 MB / 1.326 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003508/2.613, allocations: 153.4 kB / 1.745 GB, free: 13.99 MB / 1.326 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000157/2.613, allocations: 75.33 kB / 1.745 GB, free: 13.96 MB / 1.326 GB
Notification: Performance of sorting global known variables: time 0.001498/2.615, allocations: 0.8383 MB / 1.746 GB, free: 13.5 MB / 1.326 GB
Notification: Performance of sort global known variables: time 1.4e-07/2.615, allocations: 0 / 1.746 GB, free: 13.5 MB / 1.326 GB
Notification: Performance of remove unused functions: time 0.002949/2.618, allocations: 0.9791 MB / 1.747 GB, free: 13.28 MB / 1.326 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 11
 * Number of states: 16 (volEas.dynBal.medium.Xi[1],volEas.dynBal.U,volEas.dynBal.m,volEas.dynBal.mC[1],oriOutBot.mExc,oriOutTop.mExc,oriWesTop.mExc,volWes.dynBal.medium.Xi[1],volWes.dynBal.U,volWes.dynBal.m,volWes.dynBal.mC[1],oriEasTop.mExc,volTop.dynBal.medium.Xi[1],volTop.dynBal.U,volTop.dynBal.m,volTop.dynBal.mC[1])
 * Number of discrete variables: 3 ($whenCondition1,pulse.T_start,pulse.count)
 * Number of discrete states: 1 (pulse.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (217):
 * Single equations (assignments): 215
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 2
 * 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.0009983/2.619, allocations: 346.6 kB / 1.747 GB, free: 13.09 MB / 1.326 GB
Notification: Performance of simCode: created initialization part: time 0.008052/2.627, allocations: 2.57 MB / 1.749 GB, free: 11.87 MB / 1.326 GB
Notification: Performance of simCode: created event and clocks part: time 1.367e-05/2.627, allocations: 1.031 kB / 1.749 GB, free: 11.87 MB / 1.326 GB
Notification: Performance of simCode: created simulation system equations: time 0.004171/2.631, allocations: 1.307 MB / 1.751 GB, free: 11.29 MB / 1.326 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.008943/2.64, allocations: 1.142 MB / 1.752 GB, free: 10.68 MB / 1.326 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01599/2.656, allocations: 6.059 MB / 1.758 GB, free: 7.031 MB / 1.326 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002768/2.659, allocations: 1.418 MB / 1.759 GB, free: 6.285 MB / 1.326 GB
Notification: Performance of simCode: alias equations: time 0.005651/2.664, allocations: 0.7017 MB / 1.76 GB, free: 5.977 MB / 1.326 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.00125/2.665, allocations: 190.4 kB / 1.76 GB, free: 5.941 MB / 1.326 GB
Notification: Performance of SimCode: time 1.783e-06/2.665, allocations: 4 kB / 1.76 GB, free: 5.938 MB / 1.326 GB
Notification: Performance of Templates: time 0.1279/2.793, allocations: 52.72 MB / 1.811 GB, free: 3.98 MB / 1.373 GB
"
[Timeout remaining time 297]
make -j1 -f Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep.pipe ; mkfifo Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep.pipe ; head -c 1048576 < Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep.pipe >> ../files/Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep.sim & ./Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep  -abortSlowSimulation -alarm=800  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep.pipe 2>&1) [Timeout 800]
diffSimulationResults("Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Airflow_Multizone_Examples_CO2TransportStep.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Airflow.Multizone.Examples.CO2TransportStep.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 14.924116648733616]