Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea.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.001499/0.001499, allocations: 93.06 kB / 19.65 MB, free: 276 kB / 13.93 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.001845/0.001845, allocations: 165 kB / 23.02 MB, free: 1.551 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.9429/0.9429, allocations: 177.1 MB / 203.4 MB, free: 5.645 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.001585/0.001585, allocations: 235.9 kB / 260.2 MB, free: 12.83 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.7161/0.7161, allocations: 138.4 MB / 455.2 MB, free: 1.559 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.OneEffectiveAirLeakageArea,tolerance=1e-08,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea")
translateModel(BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea,tolerance=1e-08,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.352e-06/1.352e-06, allocations: 0 / 0.5551 GB, free: 0.5469 MB / 474.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.484e-05/2.619e-05, allocations: 2.312 kB / 0.5551 GB, free: 0.543 MB / 474.7 MB
Notification: Performance of NFInst.instantiate(BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea): time 0.3291/0.3291, allocations: 150.7 MB / 0.7023 GB, free: 6.164 MB / 0.5105 GB
Notification: Performance of NFInst.instExpressions: time 0.005578/0.3347, allocations: 3.946 MB / 0.7062 GB, free: 2.219 MB / 0.5105 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001287/0.336, allocations: 51.56 kB / 0.7062 GB, free: 2.168 MB / 0.5105 GB
Notification: Performance of NFTyping.typeComponents: time 0.0007885/0.3368, allocations: 266.1 kB / 0.7065 GB, free: 1.906 MB / 0.5105 GB
Notification: Performance of NFTyping.typeBindings: time 0.002121/0.3389, allocations: 1.162 MB / 0.7076 GB, free: 0.7383 MB / 0.5105 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001189/0.3401, allocations: 0.7365 MB / 0.7083 GB, free: 0 / 0.5105 GB
Notification: Performance of NFFlatten.flatten: time 0.002632/0.3427, allocations: 2.525 MB / 0.7108 GB, free: 13.47 MB / 0.5261 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008699/0.3436, allocations: 0.6294 MB / 0.7114 GB, free: 12.83 MB / 0.5261 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001487/0.3451, allocations: 1.138 MB / 0.7125 GB, free: 11.69 MB / 0.5261 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001337/0.3464, allocations: 0.7434 MB / 0.7132 GB, free: 10.96 MB / 0.5261 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001285/0.3466, allocations: 96 kB / 0.7133 GB, free: 10.87 MB / 0.5261 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0008856/0.3474, allocations: 0.5104 MB / 0.7138 GB, free: 10.36 MB / 0.5261 GB
Notification: Performance of NFScalarize.scalarize: time 0.0002956/0.3477, allocations: 410.8 kB / 0.7142 GB, free: 9.957 MB / 0.5261 GB
Notification: Performance of NFVerifyModel.verify: time 0.0003982/0.3481, allocations: 395.1 kB / 0.7146 GB, free: 9.57 MB / 0.5261 GB
Notification: Performance of NFConvertDAE.convert: time 0.001465/0.3496, allocations: 1.09 MB / 0.7156 GB, free: 8.477 MB / 0.5261 GB
Notification: Performance of FrontEnd - DAE generated: time 5.28e-06/0.3496, allocations: 0 / 0.7156 GB, free: 8.477 MB / 0.5261 GB
Notification: Performance of FrontEnd: time 1.192e-06/0.3496, allocations: 0 / 0.7156 GB, free: 8.477 MB / 0.5261 GB
Notification: Performance of Transformations before backend: time 2.618e-05/0.3496, allocations: 0 / 0.7156 GB, free: 8.477 MB / 0.5261 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 166
 * Number of variables: 166
Notification: Performance of Generate backend data structure: time 0.001727/0.3514, allocations: 1.365 MB / 0.717 GB, free: 7.074 MB / 0.5261 GB
Notification: Performance of prepare preOptimizeDAE: time 4.643e-05/0.3514, allocations: 12.69 kB / 0.717 GB, free: 7.062 MB / 0.5261 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001319/0.3527, allocations: 419.8 kB / 0.7174 GB, free: 6.652 MB / 0.5261 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0009946/0.3537, allocations: 0.7324 MB / 0.7181 GB, free: 5.887 MB / 0.5261 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.712e-05/0.3538, allocations: 53.31 kB / 0.7182 GB, free: 5.836 MB / 0.5261 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 8.935e-05/0.3538, allocations: 75.95 kB / 0.7182 GB, free: 5.762 MB / 0.5261 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0008779/0.3547, allocations: 0.7477 MB / 0.719 GB, free: 4.934 MB / 0.5261 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.828e-05/0.3547, allocations: 0 / 0.719 GB, free: 4.934 MB / 0.5261 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.36e-05/0.3548, allocations: 31.98 kB / 0.719 GB, free: 4.902 MB / 0.5261 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.518e-05/0.3548, allocations: 29.3 kB / 0.719 GB, free: 4.875 MB / 0.5261 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0004331/0.3553, allocations: 271.6 kB / 0.7193 GB, free: 4.609 MB / 0.5261 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.002378/0.3576, allocations: 2.18 MB / 0.7214 GB, free: 2.375 MB / 0.5261 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0004484/0.3581, allocations: 313.3 kB / 0.7217 GB, free: 2.055 MB / 0.5261 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0001641/0.3582, allocations: 133 kB / 0.7218 GB, free: 1.926 MB / 0.5261 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002347/0.3585, allocations: 84.44 kB / 0.7219 GB, free: 1.844 MB / 0.5261 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.799e-05/0.3585, allocations: 45.83 kB / 0.722 GB, free: 1.789 MB / 0.5261 GB
Notification: Performance of pre-optimization done (n=51): time 2.795e-06/0.3585, allocations: 0 / 0.722 GB, free: 1.789 MB / 0.5261 GB
Notification: Performance of matching and sorting (n=51): time 0.0007451/0.3593, allocations: 456.6 kB / 0.7224 GB, free: 1.34 MB / 0.5261 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.875e-05/0.3593, allocations: 59.91 kB / 0.7225 GB, free: 1.27 MB / 0.5261 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00042/0.3597, allocations: 0.5659 MB / 0.723 GB, free: 0.6875 MB / 0.5261 GB
Notification: Performance of collectPreVariables (initialization): time 3.269e-05/0.3597, allocations: 37.7 kB / 0.723 GB, free: 0.6445 MB / 0.5261 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002088/0.3599, allocations: 451.4 kB / 0.7235 GB, free: 200 kB / 0.5261 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001099/0.3601, allocations: 194.3 kB / 0.7237 GB, free: 4 kB / 0.5261 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001249/0.3602, allocations: 99.88 kB / 0.7238 GB, free: 15.89 MB / 0.5417 GB
Notification: Performance of setup shared object (initialization): time 0.0004375/0.3606, allocations: 0.5586 MB / 0.7243 GB, free: 15.32 MB / 0.5417 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0001261/0.3607, allocations: 72.95 kB / 0.7244 GB, free: 15.25 MB / 0.5417 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0001797/0.3609, allocations: 189.2 kB / 0.7245 GB, free: 15.04 MB / 0.5417 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.000303/0.3612, allocations: 267.5 kB / 0.7248 GB, free: 14.76 MB / 0.5417 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.587e-06/0.3612, allocations: 8.031 kB / 0.7248 GB, free: 14.75 MB / 0.5417 GB
Notification: Performance of matching and sorting (n=62) (initialization): time 0.0004595/0.3617, allocations: 393.1 kB / 0.7252 GB, free: 14.36 MB / 0.5417 GB
Notification: Performance of prepare postOptimizeDAE: time 1.923e-05/0.3617, allocations: 11.94 kB / 0.7252 GB, free: 14.35 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.122e-06/0.3617, allocations: 0 / 0.7252 GB, free: 14.35 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.808e-05/0.3617, allocations: 4 kB / 0.7252 GB, free: 14.34 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0002915/0.362, allocations: 119.8 kB / 0.7253 GB, free: 14.23 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.077e-05/0.362, allocations: 4 kB / 0.7253 GB, free: 14.22 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0002967/0.3623, allocations: 39.89 kB / 0.7254 GB, free: 14.18 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.502e-05/0.3624, allocations: 20 kB / 0.7254 GB, free: 14.16 MB / 0.5417 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 6
 * 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 (62):
 * Single equations (assignments): 62
 * 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.0001525/0.3625, allocations: 188.4 kB / 0.7256 GB, free: 13.97 MB / 0.5417 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 9.295e-05/0.3626, allocations: 91.47 kB / 0.7256 GB, free: 13.88 MB / 0.5417 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0004716/0.3631, allocations: 376.8 kB / 0.726 GB, free: 13.5 MB / 0.5417 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.919e-06/0.3631, allocations: 4 kB / 0.726 GB, free: 13.5 MB / 0.5417 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.938e-06/0.3631, allocations: 3.938 kB / 0.726 GB, free: 13.5 MB / 0.5417 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0004032/0.3635, allocations: 0.5923 MB / 0.7266 GB, free: 12.82 MB / 0.5417 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001194/0.3647, allocations: 1.094 MB / 0.7277 GB, free: 11.68 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.639e-06/0.3647, allocations: 4 kB / 0.7277 GB, free: 11.67 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0003623/0.3651, allocations: 135.9 kB / 0.7278 GB, free: 11.54 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (simulation): time 5.651e-06/0.3651, allocations: 4 kB / 0.7278 GB, free: 11.54 MB / 0.5417 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.211e-05/0.3651, allocations: 15.98 kB / 0.7278 GB, free: 11.52 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 3.967e-06/0.3651, allocations: 4 kB / 0.7278 GB, free: 11.52 MB / 0.5417 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.323e-06/0.3651, allocations: 0 / 0.7278 GB, free: 11.52 MB / 0.5417 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0006496/0.3657, allocations: 0.6497 MB / 0.7284 GB, free: 10.83 MB / 0.5417 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001859/0.3659, allocations: 131.3 kB / 0.7286 GB, free: 10.7 MB / 0.5417 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 5.251e-05/0.366, allocations: 12 kB / 0.7286 GB, free: 10.69 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00025/0.3662, allocations: 24.75 kB / 0.7286 GB, free: 10.67 MB / 0.5417 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.465e-05/0.3663, allocations: 36.44 kB / 0.7286 GB, free: 10.63 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 2.414e-05/0.3663, allocations: 19.98 kB / 0.7287 GB, free: 10.61 MB / 0.5417 GB
Notification: Performance of sorting global known variables: time 0.0002622/0.3666, allocations: 379 kB / 0.729 GB, free: 10.25 MB / 0.5417 GB
Notification: Performance of sort global known variables: time 2.61e-07/0.3666, allocations: 0 / 0.729 GB, free: 10.25 MB / 0.5417 GB
Notification: Performance of remove unused functions: time 0.0005122/0.3671, allocations: 275.5 kB / 0.7293 GB, free: 9.977 MB / 0.5417 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 7 (volA.dynBal.medium.Xi[1],volA.dynBal.U,volA.dynBal.m,volB.dynBal.medium.Xi[1],volB.dynBal.U,volB.dynBal.m,cra.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 (51):
 * Single equations (assignments): 51
 * 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.0002405/0.3673, allocations: 174.9 kB / 0.7295 GB, free: 9.797 MB / 0.5417 GB
Notification: Performance of simCode: created initialization part: time 0.0003912/0.3677, allocations: 274.9 kB / 0.7297 GB, free: 9.523 MB / 0.5417 GB
Notification: Performance of simCode: created event and clocks part: time 2.354e-06/0.3677, allocations: 0 / 0.7297 GB, free: 9.523 MB / 0.5417 GB
Notification: Performance of simCode: created simulation system equations: time 0.000168/0.3679, allocations: 159.4 kB / 0.7299 GB, free: 9.367 MB / 0.5417 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001101/0.369, allocations: 486.6 kB / 0.7303 GB, free: 8.949 MB / 0.5417 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002358/0.3714, allocations: 1.559 MB / 0.7319 GB, free: 7.348 MB / 0.5417 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0001325/0.3715, allocations: 199.4 kB / 0.732 GB, free: 7.129 MB / 0.5417 GB
Notification: Performance of simCode: alias equations: time 0.000399/0.3719, allocations: 158.2 kB / 0.7322 GB, free: 6.977 MB / 0.5417 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001245/0.372, allocations: 60.5 kB / 0.7322 GB, free: 6.918 MB / 0.5417 GB
Notification: Performance of SimCode: time 1.562e-06/0.372, allocations: 0 / 0.7322 GB, free: 6.918 MB / 0.5417 GB
Notification: Performance of Templates: time 0.01836/0.3904, allocations: 15.76 MB / 0.7476 GB, free: 7.598 MB / 0.5573 GB
"
[Timeout remaining time 660]
make -j1 -f BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea.makefile [Timeout 660]
(rm -f BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea.pipe ; mkfifo BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea.pipe >> ../files/BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea.sim & ./BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea -abortSlowSimulation -alarm=240  -lv LOG_STATS > BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.OneEffectiveAirLeakageArea.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 4.217858716845512]