Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.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.001084/0.001084, allocations: 92.2 kB / 20.19 MB, free: 4.359 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.001391/0.001391, allocations: 173 kB / 23.49 MB, free: 1.059 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 1.041/1.041, allocations: 177.1 MB / 203.8 MB, free: 5.625 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Examples/PPD12/Structure.mo:531:21-545:108:writable] Warning: Lexer treating \\ as \\\\, since \\e is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Examples/PPD12/Structure.mo:531:21-545:116:writable] Warning: Lexer treating \\ as \\\\, since \\< is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Media/Refrigerants/R410A/package.order:0:0-0:0:readonly] Warning: Found duplicate names in package.order file: A, B, C.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Media/Refrigerants/R410A/package.mo:2:1-70:10:writable] Warning: C was referenced in the package.order file, but was not found in package.mo, C/package.mo or C.mo.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/package.mo): time 0.7736/0.7736, allocations: 154.6 MB / 414.9 MB, free: 0.6797 MB / 378.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Utilities/Cryptographics/BaseClasses/sha.mo:2:1-19:8:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/Utilities/File/sha2.mo:2:1-9:9:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 179]
Using package IDEAS with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 4.0.0/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(IDEAS.Airflow.Multizone.Examples.CO2TransportStep,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Airflow.Multizone.Examples.CO2TransportStep")
translateModel(IDEAS.Airflow.Multizone.Examples.CO2TransportStep,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Airflow.Multizone.Examples.CO2TransportStep") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 2.584e-06/2.584e-06, allocations: 0 / 0.5204 GB, free: 2.492 MB / 490.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 4.12e-05/4.378e-05, allocations: 4.281 kB / 0.5204 GB, free: 2.488 MB / 490.7 MB
Notification: Performance of NFInst.instantiate(IDEAS.Airflow.Multizone.Examples.CO2TransportStep): time 0.5753/0.5753, allocations: 295.2 MB / 0.8087 GB, free: 22.22 MB / 0.6355 GB
Notification: Performance of NFInst.instExpressions: time 0.02548/0.6008, allocations: 23.7 MB / 0.8318 GB, free: 7.547 MB / 0.6355 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004067/0.6049, allocations: 99 kB / 0.8319 GB, free: 7.547 MB / 0.6355 GB
Notification: Performance of NFTyping.typeComponents: time 0.005491/0.6104, allocations: 1.731 MB / 0.8336 GB, free: 6.652 MB / 0.6355 GB
Notification: Performance of NFTyping.typeBindings: time 0.01755/0.6279, allocations: 6.529 MB / 0.84 GB, free: 3.148 MB / 0.6355 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00767/0.6356, allocations: 3.037 MB / 0.8429 GB, free: 0.9023 MB / 0.6355 GB
Notification: Performance of NFFlatten.flatten: time 0.009742/0.6454, allocations: 7.535 MB / 0.8503 GB, free: 12.51 MB / 0.6511 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003485/0.6488, allocations: 2.231 MB / 0.8525 GB, free: 10.95 MB / 0.6511 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.009599/0.6584, allocations: 4.254 MB / 0.8566 GB, free: 8.379 MB / 0.6511 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.006063/0.6645, allocations: 2.575 MB / 0.8591 GB, free: 5.824 MB / 0.6511 GB
Notification: Performance of NFPackage.collectConstants: time 0.001356/0.6659, allocations: 340 kB / 0.8595 GB, free: 5.492 MB / 0.6511 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01163/0.6775, allocations: 4.984 MB / 0.8643 GB, free: 0.4922 MB / 0.6511 GB
Notification: Performance of NFScalarize.scalarize: time 0.003603/0.6811, allocations: 1.609 MB / 0.8659 GB, free: 14.88 MB / 0.6667 GB
Notification: Performance of NFVerifyModel.verify: time 0.005115/0.6862, allocations: 1.38 MB / 0.8673 GB, free: 13.5 MB / 0.6667 GB
Notification: Performance of NFConvertDAE.convert: time 0.01313/0.6993, allocations: 5.476 MB / 0.8726 GB, free: 8.004 MB / 0.6667 GB
Notification: Performance of FrontEnd - DAE generated: time 7.474e-06/0.6993, allocations: 0 / 0.8726 GB, free: 8.004 MB / 0.6667 GB
Notification: Performance of FrontEnd: time 1.543e-06/0.6993, allocations: 3.938 kB / 0.8726 GB, free: 8 MB / 0.6667 GB
Notification: Performance of Transformations before backend: time 0.000128/0.6995, allocations: 0 / 0.8726 GB, free: 8 MB / 0.6667 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.006996/0.7065, allocations: 4.167 MB / 0.8767 GB, free: 3.766 MB / 0.6667 GB
Notification: Performance of prepare preOptimizeDAE: time 4.695e-05/0.7065, allocations: 8.031 kB / 0.8767 GB, free: 3.758 MB / 0.6667 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004/0.7105, allocations: 1.187 MB / 0.8778 GB, free: 2.566 MB / 0.6667 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002559/0.7131, allocations: 1.746 MB / 0.8795 GB, free: 0.7695 MB / 0.6667 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001196/0.7132, allocations: 209.4 kB / 0.8797 GB, free: 0.5625 MB / 0.6667 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002998/0.7135, allocations: 283.9 kB / 0.88 GB, free: 292 kB / 0.6667 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003386/0.7169, allocations: 2.673 MB / 0.8826 GB, free: 13.38 MB / 0.6823 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.817e-05/0.7169, allocations: 3.938 kB / 0.8826 GB, free: 13.37 MB / 0.6823 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001884/0.7171, allocations: 116 kB / 0.8827 GB, free: 13.26 MB / 0.6823 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001142/0.7172, allocations: 141.3 kB / 0.8829 GB, free: 13.12 MB / 0.6823 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002391/0.7196, allocations: 1.358 MB / 0.8842 GB, free: 11.74 MB / 0.6823 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.009444/0.7291, allocations: 9.149 MB / 0.8931 GB, free: 2.395 MB / 0.6823 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001845/0.7309, allocations: 1.266 MB / 0.8944 GB, free: 1.133 MB / 0.6823 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0008935/0.7318, allocations: 0.6482 MB / 0.895 GB, free: 496 kB / 0.6823 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005029/0.7323, allocations: 193.9 kB / 0.8952 GB, free: 300 kB / 0.6823 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001237/0.7335, allocations: 1.039 MB / 0.8962 GB, free: 15.16 MB / 0.698 GB
Notification: Performance of pre-optimization done (n=213): time 5.921e-06/0.7335, allocations: 0 / 0.8962 GB, free: 15.16 MB / 0.698 GB
Notification: Performance of matching and sorting (n=213): time 0.002997/0.7365, allocations: 1.759 MB / 0.8979 GB, free: 13.4 MB / 0.698 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.043e-05/0.7366, allocations: 77.34 kB / 0.898 GB, free: 13.31 MB / 0.698 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00122/0.7378, allocations: 1.172 MB / 0.8991 GB, free: 12.11 MB / 0.698 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001188/0.7379, allocations: 65.7 kB / 0.8992 GB, free: 12.04 MB / 0.698 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008174/0.7388, allocations: 1.194 MB / 0.9004 GB, free: 10.84 MB / 0.698 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0006074/0.7394, allocations: 0.7668 MB / 0.9011 GB, free: 10.07 MB / 0.698 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003983/0.7398, allocations: 373.2 kB / 0.9015 GB, free: 9.691 MB / 0.698 GB
Notification: Performance of setup shared object (initialization): time 0.0001136/0.7399, allocations: 480.7 kB / 0.9019 GB, free: 9.219 MB / 0.698 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0007088/0.7406, allocations: 393.5 kB / 0.9023 GB, free: 8.824 MB / 0.698 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00116/0.7417, allocations: 0.9734 MB / 0.9033 GB, free: 7.652 MB / 0.698 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001607/0.7434, allocations: 1.3 MB / 0.9045 GB, free: 6.207 MB / 0.698 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.244e-06/0.7434, allocations: 4 kB / 0.9045 GB, free: 6.203 MB / 0.698 GB
Notification: Performance of matching and sorting (n=259) (initialization): time 0.002304/0.7457, allocations: 1.617 MB / 0.9061 GB, free: 4.566 MB / 0.698 GB
Notification: Performance of prepare postOptimizeDAE: time 4.966e-05/0.7457, allocations: 37.7 kB / 0.9061 GB, free: 4.523 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.553e-05/0.7457, allocations: 8.125 kB / 0.9062 GB, free: 4.516 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.039e-05/0.7458, allocations: 23.98 kB / 0.9062 GB, free: 4.492 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001068/0.7468, allocations: 459.3 kB / 0.9066 GB, free: 4.043 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.496e-05/0.7469, allocations: 19.94 kB / 0.9066 GB, free: 4.023 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009746/0.7478, allocations: 167.7 kB / 0.9068 GB, free: 3.859 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001078/0.7479, allocations: 79.98 kB / 0.9069 GB, free: 3.781 MB / 0.698 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.0006041/0.7485, allocations: 280 kB / 0.9071 GB, free: 3.496 MB / 0.698 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003166/0.7489, allocations: 274.7 kB / 0.9074 GB, free: 3.227 MB / 0.698 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002064/0.7509, allocations: 1.523 MB / 0.9089 GB, free: 1.688 MB / 0.698 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.329e-05/0.7509, allocations: 24 kB / 0.9089 GB, free: 1.664 MB / 0.698 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.591e-06/0.7509, allocations: 0 / 0.9089 GB, free: 1.664 MB / 0.698 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001778/0.7527, allocations: 1.355 MB / 0.9102 GB, free: 248 kB / 0.698 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004796/0.7575, allocations: 3.658 MB / 0.9138 GB, free: 12.48 MB / 0.7136 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.177e-06/0.7575, allocations: 5.312 kB / 0.9138 GB, free: 12.48 MB / 0.7136 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001154/0.7587, allocations: 463.8 kB / 0.9143 GB, free: 12.03 MB / 0.7136 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.371e-05/0.7587, allocations: 8 kB / 0.9143 GB, free: 12.02 MB / 0.7136 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001061/0.7588, allocations: 51.98 kB / 0.9143 GB, free: 11.97 MB / 0.7136 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.545e-05/0.7588, allocations: 12 kB / 0.9143 GB, free: 11.96 MB / 0.7136 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.188e-06/0.7588, allocations: 3.938 kB / 0.9143 GB, free: 11.95 MB / 0.7136 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002697/0.7615, allocations: 2.192 MB / 0.9165 GB, free: 9.699 MB / 0.7136 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0009963/0.7625, allocations: 450 kB / 0.9169 GB, free: 9.258 MB / 0.7136 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002338/0.7627, allocations: 43.98 kB / 0.9169 GB, free: 9.215 MB / 0.7136 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007261/0.7635, allocations: 58.88 kB / 0.917 GB, free: 9.16 MB / 0.7136 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002382/0.7637, allocations: 165.6 kB / 0.9171 GB, free: 8.996 MB / 0.7136 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 9.351e-05/0.7638, allocations: 71.97 kB / 0.9172 GB, free: 8.926 MB / 0.7136 GB
Notification: Performance of sorting global known variables: time 0.0006873/0.7645, allocations: 0.6964 MB / 0.9179 GB, free: 8.23 MB / 0.7136 GB
Notification: Performance of sort global known variables: time 2.4e-07/0.7645, allocations: 4 kB / 0.9179 GB, free: 8.227 MB / 0.7136 GB
Notification: Performance of remove unused functions: time 0.001858/0.7663, allocations: 0.9667 MB / 0.9188 GB, free: 7.258 MB / 0.7136 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.0005988/0.7669, allocations: 379.5 kB / 0.9192 GB, free: 6.883 MB / 0.7136 GB
Notification: Performance of simCode: created initialization part: time 0.001916/0.7689, allocations: 1.308 MB / 0.9205 GB, free: 5.551 MB / 0.7136 GB
Notification: Performance of simCode: created event and clocks part: time 4.198e-06/0.7689, allocations: 0 / 0.9205 GB, free: 5.551 MB / 0.7136 GB
Notification: Performance of simCode: created simulation system equations: time 0.0008015/0.7697, allocations: 0.7017 MB / 0.9212 GB, free: 4.844 MB / 0.7136 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002719/0.7724, allocations: 1.158 MB / 0.9223 GB, free: 3.742 MB / 0.7136 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006571/0.779, allocations: 4.846 MB / 0.927 GB, free: 14.8 MB / 0.7292 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000472/0.7794, allocations: 0.6301 MB / 0.9276 GB, free: 14.14 MB / 0.7292 GB
Notification: Performance of simCode: alias equations: time 0.001652/0.7811, allocations: 0.5864 MB / 0.9282 GB, free: 13.55 MB / 0.7292 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004772/0.7816, allocations: 184.5 kB / 0.9284 GB, free: 13.37 MB / 0.7292 GB
Notification: Performance of SimCode: time 2.765e-06/0.7816, allocations: 0 / 0.9284 GB, free: 13.37 MB / 0.7292 GB
Notification: Performance of Templates: time 0.2795/1.061, allocations: 44.42 MB / 0.9718 GB, free: 295.1 MB / 0.7448 GB
"
[Timeout remaining time 659]
make -j1 -f IDEAS_IDEAS.Airflow.Multizone.Examples.CO2TransportStep.makefile [Timeout 660]
(rm -f IDEAS_IDEAS.Airflow.Multizone.Examples.CO2TransportStep.pipe ; mkfifo IDEAS_IDEAS.Airflow.Multizone.Examples.CO2TransportStep.pipe ; head -c 1048576 < IDEAS_IDEAS.Airflow.Multizone.Examples.CO2TransportStep.pipe >> ../files/IDEAS_IDEAS.Airflow.Multizone.Examples.CO2TransportStep.sim & ./IDEAS_IDEAS.Airflow.Multizone.Examples.CO2TransportStep -abortSlowSimulation -alarm=240  -lv LOG_STATS > IDEAS_IDEAS.Airflow.Multizone.Examples.CO2TransportStep.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 5.870994862169027]