Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.PressurizationData.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.0009195/0.0009195, allocations: 81.17 kB / 19.87 MB, free: 4.621 MB / 18.57 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.001749/0.001749, allocations: 169 kB / 23.27 MB, free: 1.223 MB / 18.57 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 0.9211/0.9211, allocations: 177.1 MB / 203.7 MB, free: 5.523 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 master/package.mo): time 0.001602/0.001602, allocations: 233.8 kB / 260.5 MB, free: 12.68 MB / 250.7 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo): time 0.7216/0.7216, allocations: 138.4 MB / 455.5 MB, free: 1.418 MB / 362.7 MB
"
[Timeout remaining time 179]
Using package BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo)
Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 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(BuildingSystems.Airflow.Multizone.Examples.PressurizationData,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.PressurizationData")
translateModel(BuildingSystems.Airflow.Multizone.Examples.PressurizationData,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.PressurizationData") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.082e-06/1.082e-06, allocations: 0 / 0.5556 GB, free: 288 kB / 474.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.548e-05/1.656e-05, allocations: 2.312 kB / 0.5556 GB, free: 284 kB / 474.7 MB
Notification: Performance of NFInst.instantiate(BuildingSystems.Airflow.Multizone.Examples.PressurizationData): time 0.3087/0.3088, allocations: 150.3 MB / 0.7023 GB, free: 5.961 MB / 0.5105 GB
Notification: Performance of NFInst.instExpressions: time 0.01229/0.3211, allocations: 12.8 MB / 0.7149 GB, free: 9.148 MB / 0.5261 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001364/0.3224, allocations: 59.5 kB / 0.7149 GB, free: 9.09 MB / 0.5261 GB
Notification: Performance of NFTyping.typeComponents: time 0.0009293/0.3233, allocations: 460.2 kB / 0.7153 GB, free: 8.637 MB / 0.5261 GB
Notification: Performance of NFTyping.typeBindings: time 0.003057/0.3264, allocations: 1.789 MB / 0.7171 GB, free: 6.84 MB / 0.5261 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002415/0.3288, allocations: 1.527 MB / 0.7186 GB, free: 5.309 MB / 0.5261 GB
Notification: Performance of NFFlatten.flatten: time 0.003272/0.3321, allocations: 3.702 MB / 0.7222 GB, free: 1.594 MB / 0.5261 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001611/0.3337, allocations: 1.582 MB / 0.7237 GB, free: 15.95 MB / 0.5417 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003052/0.3368, allocations: 2.234 MB / 0.7259 GB, free: 13.82 MB / 0.5417 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.000993/0.3377, allocations: 1.043 MB / 0.7269 GB, free: 12.77 MB / 0.5417 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002024/0.3379, allocations: 204 kB / 0.7271 GB, free: 12.57 MB / 0.5417 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001623/0.3396, allocations: 1.072 MB / 0.7282 GB, free: 11.5 MB / 0.5417 GB
Notification: Performance of NFScalarize.scalarize: time 0.0006513/0.3402, allocations: 0.6736 MB / 0.7288 GB, free: 10.82 MB / 0.5417 GB
Notification: Performance of NFVerifyModel.verify: time 0.0005628/0.3408, allocations: 0.7715 MB / 0.7296 GB, free: 10.05 MB / 0.5417 GB
Notification: Performance of NFConvertDAE.convert: time 0.002667/0.3434, allocations: 2.421 MB / 0.732 GB, free: 7.621 MB / 0.5417 GB
Notification: Performance of FrontEnd - DAE generated: time 4.308e-06/0.3435, allocations: 3.938 kB / 0.732 GB, free: 7.617 MB / 0.5417 GB
Notification: Performance of FrontEnd: time 1.302e-06/0.3435, allocations: 0 / 0.732 GB, free: 7.617 MB / 0.5417 GB
Notification: Performance of Transformations before backend: time 1.399e-05/0.3435, allocations: 0 / 0.732 GB, free: 7.617 MB / 0.5417 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 421
 * Number of variables: 421
Notification: Performance of Generate backend data structure: time 0.002453/0.3459, allocations: 2.597 MB / 0.7345 GB, free: 4.965 MB / 0.5417 GB
Notification: Performance of prepare preOptimizeDAE: time 3.887e-05/0.346, allocations: 16.75 kB / 0.7345 GB, free: 4.949 MB / 0.5417 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001976/0.3479, allocations: 0.7586 MB / 0.7353 GB, free: 4.188 MB / 0.5417 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001304/0.3492, allocations: 1.212 MB / 0.7364 GB, free: 2.926 MB / 0.5417 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.523e-05/0.3493, allocations: 127.3 kB / 0.7366 GB, free: 2.801 MB / 0.5417 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001556/0.3495, allocations: 172 kB / 0.7367 GB, free: 2.633 MB / 0.5417 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001494/0.351, allocations: 1.834 MB / 0.7385 GB, free: 0.5664 MB / 0.5417 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.873e-05/0.351, allocations: 0 / 0.7385 GB, free: 0.5664 MB / 0.5417 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.77e-05/0.3511, allocations: 76 kB / 0.7386 GB, free: 0.4922 MB / 0.5417 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.872e-05/0.3511, allocations: 63.16 kB / 0.7387 GB, free: 440 kB / 0.5417 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001084/0.3522, allocations: 0.9738 MB / 0.7396 GB, free: 15.45 MB / 0.5573 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.004455/0.3567, allocations: 4.862 MB / 0.7444 GB, free: 10.48 MB / 0.5573 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.000911/0.3576, allocations: 0.7361 MB / 0.7451 GB, free: 9.738 MB / 0.5573 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003009/0.3579, allocations: 296.1 kB / 0.7454 GB, free: 9.445 MB / 0.5573 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004103/0.3583, allocations: 159.9 kB / 0.7455 GB, free: 9.312 MB / 0.5573 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0006923/0.359, allocations: 1.011 MB / 0.7465 GB, free: 8.168 MB / 0.5573 GB
Notification: Performance of pre-optimization done (n=142): time 2.795e-06/0.359, allocations: 0 / 0.7465 GB, free: 8.168 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=142): time 0.002106/0.3611, allocations: 1.281 MB / 0.7477 GB, free: 6.867 MB / 0.5573 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.515e-05/0.3612, allocations: 197.2 kB / 0.7479 GB, free: 6.633 MB / 0.5573 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0006837/0.3618, allocations: 0.9558 MB / 0.7489 GB, free: 5.664 MB / 0.5573 GB
Notification: Performance of collectPreVariables (initialization): time 7.229e-05/0.3619, allocations: 57.7 kB / 0.7489 GB, free: 5.602 MB / 0.5573 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006422/0.3626, allocations: 0.8323 MB / 0.7497 GB, free: 4.758 MB / 0.5573 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002629/0.3628, allocations: 0.4957 MB / 0.7502 GB, free: 4.258 MB / 0.5573 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002629/0.3631, allocations: 289 kB / 0.7505 GB, free: 3.965 MB / 0.5573 GB
Notification: Performance of setup shared object (initialization): time 8.893e-05/0.3632, allocations: 480.8 kB / 0.751 GB, free: 3.492 MB / 0.5573 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002253/0.3634, allocations: 183.8 kB / 0.7511 GB, free: 3.312 MB / 0.5573 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.000408/0.3638, allocations: 0.6001 MB / 0.7517 GB, free: 2.59 MB / 0.5573 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0006715/0.3645, allocations: 0.7178 MB / 0.7524 GB, free: 1.781 MB / 0.5573 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.278e-06/0.3645, allocations: 3.938 kB / 0.7524 GB, free: 1.777 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=180) (initialization): time 0.001328/0.3658, allocations: 1.061 MB / 0.7535 GB, free: 0.6953 MB / 0.5573 GB
Notification: Performance of prepare postOptimizeDAE: time 1.745e-05/0.3658, allocations: 8 kB / 0.7535 GB, free: 0.6875 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.043e-05/0.3658, allocations: 4 kB / 0.7535 GB, free: 0.6836 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005315/0.3664, allocations: 215.3 kB / 0.7537 GB, free: 472 kB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006516/0.367, allocations: 315.6 kB / 0.754 GB, free: 156 kB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002691/0.3697, allocations: 5.377 MB / 0.7592 GB, free: 10.43 MB / 0.573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006301/0.3703, allocations: 129.5 kB / 0.7593 GB, free: 10.31 MB / 0.573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.465e-05/0.3704, allocations: 51.97 kB / 0.7594 GB, free: 10.26 MB / 0.573 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 21
 * Number of states: 0 ()
 * Number of discrete variables: 17 (weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,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,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (174):
 * Single equations (assignments): 171
 * 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): 2 systems
   {(1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003497/0.3708, allocations: 244 kB / 0.7596 GB, free: 10.01 MB / 0.573 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002249/0.371, allocations: 211 kB / 0.7598 GB, free: 9.805 MB / 0.573 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001429/0.3724, allocations: 1.202 MB / 0.761 GB, free: 8.582 MB / 0.573 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.534e-06/0.3724, allocations: 16 kB / 0.761 GB, free: 8.566 MB / 0.573 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.196e-06/0.3724, allocations: 0 / 0.761 GB, free: 8.566 MB / 0.573 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.000949/0.3734, allocations: 0.8891 MB / 0.7619 GB, free: 7.633 MB / 0.573 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002565/0.3759, allocations: 2.125 MB / 0.764 GB, free: 5.461 MB / 0.573 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.288e-06/0.3759, allocations: 4 kB / 0.764 GB, free: 5.457 MB / 0.573 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006014/0.3765, allocations: 291.6 kB / 0.7642 GB, free: 5.172 MB / 0.573 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0003941/0.3769, allocations: 174.9 kB / 0.7644 GB, free: 4.988 MB / 0.573 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.762e-05/0.377, allocations: 39.97 kB / 0.7644 GB, free: 4.949 MB / 0.573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002165/0.3792, allocations: 5.384 MB / 0.7697 GB, free: 15.21 MB / 0.5886 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 9.52e-07/0.3792, allocations: 3.938 kB / 0.7697 GB, free: 15.21 MB / 0.5886 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001913/0.3811, allocations: 1.441 MB / 0.7711 GB, free: 13.74 MB / 0.5886 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004366/0.3815, allocations: 330.4 kB / 0.7714 GB, free: 13.42 MB / 0.5886 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001142/0.3816, allocations: 32 kB / 0.7715 GB, free: 13.39 MB / 0.5886 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004653/0.3821, allocations: 62.2 kB / 0.7715 GB, free: 13.33 MB / 0.5886 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001325/0.3822, allocations: 109.1 kB / 0.7716 GB, free: 13.22 MB / 0.5886 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.008e-05/0.3823, allocations: 55.97 kB / 0.7717 GB, free: 13.16 MB / 0.5886 GB
Notification: Performance of sorting global known variables: time 0.0003896/0.3827, allocations: 0.5529 MB / 0.7722 GB, free: 12.61 MB / 0.5886 GB
Notification: Performance of sort global known variables: time 6e-08/0.3827, allocations: 0 / 0.7722 GB, free: 12.61 MB / 0.5886 GB
Notification: Performance of remove unused functions: time 0.001205/0.3839, allocations: 0.6741 MB / 0.7729 GB, free: 11.93 MB / 0.5886 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 5 (room.dynBal.medium.Xi[1],room.dynBal.U,room.dynBal.m,pow_1dat.mExc,pow_1dat1.mExc)
 * Number of discrete variables: 10 ($whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext)
 * Number of discrete states: 5 (weaDat.locTim.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,weaDat.conTimMin.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (151):
 * Single equations (assignments): 143
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 5
 * 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): 2 systems
   {(1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.001335/0.3852, allocations: 0.7327 MB / 0.7736 GB, free: 11.41 MB / 0.5886 GB
Notification: Performance of simCode: created initialization part: time 0.001188/0.3864, allocations: 1.257 MB / 0.7748 GB, free: 10.11 MB / 0.5886 GB
Notification: Performance of simCode: created event and clocks part: time 3.126e-06/0.3864, allocations: 4.688 kB / 0.7748 GB, free: 10.1 MB / 0.5886 GB
Notification: Performance of simCode: created simulation system equations: time 0.000658/0.3871, allocations: 0.9442 MB / 0.7757 GB, free: 9.102 MB / 0.5886 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001442/0.3885, allocations: 0.7079 MB / 0.7764 GB, free: 8.426 MB / 0.5886 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003845/0.3924, allocations: 2.986 MB / 0.7794 GB, free: 5.395 MB / 0.5886 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0002461/0.3926, allocations: 361.8 kB / 0.7797 GB, free: 5.012 MB / 0.5886 GB
Notification: Performance of simCode: alias equations: time 0.0008666/0.3935, allocations: 340.1 kB / 0.78 GB, free: 4.676 MB / 0.5886 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001143/0.3946, allocations: 0.6852 MB / 0.7807 GB, free: 3.988 MB / 0.5886 GB
Notification: Performance of SimCode: time 1.473e-06/0.3946, allocations: 4 kB / 0.7807 GB, free: 3.984 MB / 0.5886 GB
Notification: Performance of Templates: time 0.03848/0.4331, allocations: 34.08 MB / 0.814 GB, free: 2.48 MB / 0.6198 GB
"
[Timeout remaining time 660]
make -j1 -f BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.PressurizationData.makefile [Timeout 660]
(rm -f BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.PressurizationData.pipe ; mkfifo BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.PressurizationData.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.PressurizationData.pipe >> ../files/BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.PressurizationData.sim & ./BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.PressurizationData -abortSlowSimulation -alarm=240  -lv LOG_STATS > BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.PressurizationData.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 5.310781196691096]