Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_8_Buildings.Examples.VAVCO2.VAVSystemCTControl.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 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/package.mo", uses=false)
Using package Buildings with version 8.1.4 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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.Examples.VAVCO2.VAVSystemCTControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8_Buildings.Examples.VAVCO2.VAVSystemCTControl")
translateModel(Buildings.Examples.VAVCO2.VAVSystemCTControl,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8_Buildings.Examples.VAVCO2.VAVSystemCTControl")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001431/0.001431, allocations: 108.4 kB / 16.38 MB, free: 6.484 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.001634/0.001634, allocations: 194 kB / 17.32 MB, free: 5.816 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.393/1.393, allocations: 205.1 MB / 223.2 MB, free: 12.27 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.4-maint.8.1.x/package.mo): time 1.798/1.798, allocations: 292.3 MB / 0.5496 GB, free: 17.66 MB / 462.1 MB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.001697/0.001697, allocations: 59.91 kB / 0.6729 GB, free: 5.875 MB / 0.545 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2789/0.2806, allocations: 114.6 MB / 0.7848 GB, free: 3.203 MB / 0.6544 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.VAVCO2.VAVSystemCTControl): time 2.92/3.2, allocations: 1.243 GB / 2.027 GB, free: 1.059 MB / 1.264 GB
Notification: Performance of NFInst.instExpressions: time 1.311/4.511, allocations: 125 MB / 2.149 GB, free: 15.48 MB / 1.279 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.04739/4.559, allocations: 0.7373 MB / 2.15 GB, free: 15.48 MB / 1.279 GB
Notification: Performance of NFTyping.typeComponents: time 0.03826/4.597, allocations: 10.64 MB / 2.161 GB, free: 15.32 MB / 1.279 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Utilities/Strings.mo:139:3-175:14:writable] Warning: Pure function 'Modelica.Utilities.Strings.isEmpty' contains a call to impure function 'Modelica.Utilities.Strings.Advanced.skipWhiteSpace'.
Notification: Performance of NFTyping.typeBindings: time 0.09025/4.687, allocations: 25.83 MB / 2.186 GB, free: 14.2 MB / 1.279 GB
Notification: Performance of NFTyping.typeClassSections: time 0.05459/4.742, allocations: 18.43 MB / 2.204 GB, free: 5.867 MB / 1.279 GB
Notification: Performance of NFFlatten.flatten: time 0.07626/4.818, allocations: 46.87 MB / 2.25 GB, free: 2.152 MB / 1.295 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04802/4.866, allocations: 22.46 MB / 2.272 GB, free: 1.848 MB / 1.311 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.06712/4.933, allocations: 24.74 MB / 2.296 GB, free: 11.18 MB / 1.342 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03671/4.97, allocations: 16.21 MB / 2.312 GB, free: 12.14 MB / 1.357 GB
Notification: Performance of NFPackage.collectConstants: time 0.014/4.984, allocations: 2.949 MB / 2.314 GB, free: 9.191 MB / 1.357 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.05408/5.038, allocations: 17.7 MB / 2.332 GB, free: 9.496 MB / 1.373 GB
Notification: Performance of NFScalarize.scalarize: time 0.02415/5.063, allocations: 8.883 MB / 2.34 GB, free: 0.8203 MB / 1.373 GB
Notification: Performance of NFVerifyModel.verify: time 0.03788/5.1, allocations: 12.81 MB / 2.353 GB, free: 4.113 MB / 1.389 GB
Notification: Performance of NFConvertDAE.convert: time 0.08585/5.186, allocations: 42.61 MB / 2.394 GB, free: 10.78 MB / 1.436 GB
Notification: Performance of FrontEnd - DAE generated: time 5.621e-06/5.186, allocations: 0 / 2.394 GB, free: 10.78 MB / 1.436 GB
Notification: Performance of FrontEnd: time 2.324e-06/5.186, allocations: 0 / 2.394 GB, free: 10.78 MB / 1.436 GB
Notification: Performance of Transformations before backend: time 0.001368/5.188, allocations: 4 kB / 2.394 GB, free: 10.77 MB / 1.436 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3092
 * Number of variables: 3092
Notification: Performance of Generate backend data structure: time 0.07863/5.266, allocations: 22.66 MB / 2.417 GB, free: 4.094 MB / 1.451 GB
Notification: Performance of prepare preOptimizeDAE: time 5.69e-05/5.266, allocations: 8.031 kB / 2.417 GB, free: 4.086 MB / 1.451 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02779/5.294, allocations: 4.01 MB / 2.421 GB, free: 72 kB / 1.451 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0479/5.342, allocations: 16.84 MB / 2.437 GB, free: 15.42 MB / 1.482 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001288/5.344, allocations: 0.9589 MB / 2.438 GB, free: 14.46 MB / 1.482 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00655/5.35, allocations: 1.301 MB / 2.439 GB, free: 13.17 MB / 1.482 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05351/5.404, allocations: 17.38 MB / 2.456 GB, free: 11.51 MB / 1.498 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0005294/5.404, allocations: 11.84 kB / 2.456 GB, free: 11.5 MB / 1.498 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004496/5.409, allocations: 0.4983 MB / 2.457 GB, free: 11.01 MB / 1.498 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000458/5.409, allocations: 467.8 kB / 2.457 GB, free: 10.55 MB / 1.498 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.04134/5.451, allocations: 15.87 MB / 2.473 GB, free: 10.68 MB / 1.514 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.1537/5.604, allocations: 83.44 MB / 2.554 GB, free: 2.035 MB / 1.592 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02183/5.626, allocations: 10.07 MB / 2.564 GB, free: 8.023 MB / 1.607 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01353/5.64, allocations: 6.836 MB / 2.571 GB, free: 1.18 MB / 1.607 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001182/5.641, allocations: 326 kB / 2.571 GB, free: 0.8984 MB / 1.607 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01594/5.657, allocations: 6.955 MB / 2.578 GB, free: 9.898 MB / 1.623 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01328/5.67, allocations: 1.855 MB / 2.579 GB, free: 8.098 MB / 1.623 GB
Notification: Performance of pre-optimization done (n=876): time 4.333e-05/5.67, allocations: 0 / 2.579 GB, free: 8.098 MB / 1.623 GB
Notification: Performance of matching and sorting (n=876): time 0.1208/5.791, allocations: 31.2 MB / 2.61 GB, free: 8.691 MB / 1.654 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003181/5.792, allocations: 0.6236 MB / 2.611 GB, free: 7.938 MB / 1.654 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.8647/6.656, allocations: 13.72 MB / 2.624 GB, free: 0.9486 GB / 1.654 GB
Notification: Performance of collectPreVariables (initialization): time 0.00574/6.662, allocations: 236 kB / 2.624 GB, free: 0.9486 GB / 1.654 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01488/6.677, allocations: 7.807 MB / 2.632 GB, free: 0.9456 GB / 1.654 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00599/6.683, allocations: 3.025 MB / 2.635 GB, free: 0.9439 GB / 1.654 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0107/6.694, allocations: 1.994 MB / 2.637 GB, free: 0.9431 GB / 1.654 GB
Notification: Performance of setup shared object (initialization): time 5.6e-05/6.694, allocations: 301.9 kB / 2.637 GB, free: 0.9428 GB / 1.654 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01291/6.707, allocations: 5.449 MB / 2.642 GB, free: 0.9406 GB / 1.654 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01615/6.723, allocations: 8.4 MB / 2.651 GB, free: 0.935 GB / 1.654 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02799/6.751, allocations: 13.18 MB / 2.663 GB, free: 0.9282 GB / 1.654 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001273/6.751, allocations: 10.12 kB / 2.663 GB, free: 0.9282 GB / 1.654 GB
Notification: Performance of matching and sorting (n=1158) (initialization): time 0.0687/6.82, allocations: 19.56 MB / 2.683 GB, free: 0.9213 GB / 1.654 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001307/6.82, allocations: 20.66 kB / 2.683 GB, free: 0.9213 GB / 1.654 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001794/6.82, allocations: 47.31 kB / 2.683 GB, free: 0.9213 GB / 1.654 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02565/6.846, allocations: 5.44 MB / 2.688 GB, free: 0.9202 GB / 1.654 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01082/6.857, allocations: 1.881 MB / 2.69 GB, free: 0.9201 GB / 1.654 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04378/6.901, allocations: 33.73 MB / 2.723 GB, free: 0.8976 GB / 1.654 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02144/6.922, allocations: 0.6357 MB / 2.723 GB, free: 0.8975 GB / 1.654 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003009/6.925, allocations: 486.5 kB / 2.724 GB, free: 0.8974 GB / 1.654 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02005/6.945, allocations: 9.158 MB / 2.733 GB, free: 0.8932 GB / 1.654 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01274/6.958, allocations: 8.24 MB / 2.741 GB, free: 0.8877 GB / 1.654 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.02285/6.981, allocations: 12.83 MB / 2.753 GB, free: 0.8808 GB / 1.654 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.462e-05/6.981, allocations: 11.78 kB / 2.753 GB, free: 0.8808 GB / 1.654 GB
Notification: Performance of matching and sorting (n=1158) (initialization_lambda0): time 0.05847/7.04, allocations: 18.74 MB / 2.772 GB, free: 0.8732 GB / 1.654 GB
Notification: Performance of prepare postOptimizeDAE: time 5.944e-05/7.04, allocations: 19.94 kB / 2.772 GB, free: 0.8732 GB / 1.654 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001081/7.04, allocations: 48.95 kB / 2.772 GB, free: 0.8732 GB / 1.654 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02085/7.061, allocations: 4.832 MB / 2.776 GB, free: 0.871 GB / 1.654 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009482/7.07, allocations: 1.779 MB / 2.778 GB, free: 0.8705 GB / 1.654 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05038/7.121, allocations: 38.27 MB / 2.815 GB, free: 0.8328 GB / 1.654 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01894/7.14, allocations: 0.7826 MB / 2.816 GB, free: 0.8321 GB / 1.654 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002943/7.143, allocations: 463.6 kB / 2.817 GB, free: 0.8316 GB / 1.654 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 168
 * Number of states: 0 ()
 * Number of discrete variables: 34 ($PRE.roo.occ.office1.nextTimeEvent,$whenCondition7,$PRE.roo.occ.office2.nextTimeEvent,$whenCondition6,$PRE.roo.occ.cla1.nextTimeEvent,$whenCondition5,$PRE.roo.occ.cla2.nextTimeEvent,$whenCondition4,$PRE.roo.occ.smaRoo1.nextTimeEvent,$whenCondition3,$PRE.roo.occ.smaRoo2.nextTimeEvent,$whenCondition2,$whenCondition1,onSig.pulseStart,$PRE.onSig.pulseStart,onSig.y,roo.occ.smaRoo2.nextTimeEventScaled,$PRE.roo.occ.smaRoo2.nextTimeEventScaled,roo.occ.smaRoo2.nextTimeEvent,roo.occ.smaRoo1.nextTimeEventScaled,$PRE.roo.occ.smaRoo1.nextTimeEventScaled,roo.occ.smaRoo1.nextTimeEvent,roo.occ.cla2.nextTimeEventScaled,$PRE.roo.occ.cla2.nextTimeEventScaled,roo.occ.cla2.nextTimeEvent,roo.occ.cla1.nextTimeEventScaled,$PRE.roo.occ.cla1.nextTimeEventScaled,roo.occ.cla1.nextTimeEvent,roo.occ.office2.nextTimeEventScaled,$PRE.roo.occ.office2.nextTimeEventScaled,roo.occ.office2.nextTimeEvent,roo.occ.office1.nextTimeEventScaled,$PRE.roo.occ.office1.nextTimeEventScaled,roo.occ.office1.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (968):
 * Single equations (assignments): 937
 * Array equations: 8
 * Algorithm blocks: 0
 * Record equations: 6
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 8
 * Torn equation systems: 9
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 8 systems
   {1, 1, 1, 1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 6 systems
   {(4,9,87.5%), (4,9,87.5%), (4,9,81.2%), (4,9,81.2%), (4,9,87.5%), (4,9,87.5%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(2,10), (15,43), (9,26)}
Notification: Performance of prepare postOptimizeDAE: time 0.00681/7.149, allocations: 0.7427 MB / 2.817 GB, free: 0.8309 GB / 1.654 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.008355/7.158, allocations: 1.451 MB / 2.819 GB, free: 0.8295 GB / 1.654 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04335/7.201, allocations: 15.95 MB / 2.834 GB, free: 0.814 GB / 1.654 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.03096/7.232, allocations: 13.16 MB / 2.847 GB, free: 0.8011 GB / 1.654 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.608e-05/7.232, allocations: 0 / 2.847 GB, free: 0.8011 GB / 1.654 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01087/7.243, allocations: 3.052 MB / 2.85 GB, free: 0.7981 GB / 1.654 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006879/7.25, allocations: 217.6 kB / 2.85 GB, free: 0.7979 GB / 1.654 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01415/7.264, allocations: 428.3 kB / 2.851 GB, free: 0.7975 GB / 1.654 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002923/7.267, allocations: 0.6817 MB / 2.852 GB, free: 0.7968 GB / 1.654 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.04056/7.308, allocations: 15.21 MB / 2.866 GB, free: 0.7822 GB / 1.654 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.04228/7.35, allocations: 20.31 MB / 2.886 GB, free: 0.7623 GB / 1.654 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.009574/7.36, allocations: 5.781 MB / 2.892 GB, free: 0.7567 GB / 1.654 GB
Notification: Performance of sorting global known variables: time 0.02181/7.382, allocations: 9.412 MB / 2.901 GB, free: 0.7476 GB / 1.654 GB
Notification: Performance of Backend: time 7.41e-07/7.382, allocations: 0 / 2.901 GB, free: 0.7476 GB / 1.654 GB
Notification: Performance of simCode: created initialization part: time 0.07027/7.452, allocations: 23.76 MB / 2.924 GB, free: 0.7251 GB / 1.654 GB
Notification: Performance of SimCode: time 0.09179/7.544, allocations: 38.26 MB / 2.962 GB, free: 0.6881 GB / 1.654 GB
Notification: Performance of Templates: time 0.5589/8.103, allocations: 382.7 MB / 3.335 GB, free: 324.4 MB / 1.654 GB
make -j1 -f Buildings_8_Buildings.Examples.VAVCO2.VAVSystemCTControl.makefile
(rm -f Buildings_8_Buildings.Examples.VAVCO2.VAVSystemCTControl.pipe ; mkfifo Buildings_8_Buildings.Examples.VAVCO2.VAVSystemCTControl.pipe ; head -c 1048576 < Buildings_8_Buildings.Examples.VAVCO2.VAVSystemCTControl.pipe >> ../files/Buildings_8_Buildings.Examples.VAVCO2.VAVSystemCTControl.sim & ./Buildings_8_Buildings.Examples.VAVCO2.VAVSystemCTControl  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_8_Buildings.Examples.VAVCO2.VAVSystemCTControl.pipe 2>&1)