Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl.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.001828/0.001828, allocations: 78.02 kB / 19.18 MB, free: 2.531 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.002167/0.002167, allocations: 170.7 kB / 22.46 MB, free: 5.359 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.508/1.508, allocations: 177.1 MB / 202.8 MB, free: 9.164 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo): time 2.669/2.669, allocations: 359 MB / 0.6037 GB, free: 14.96 MB / 0.5762 GB
"
[Timeout remaining time 177]
Using package Buildings with version 11.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/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.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|roo.yCFD.1.|roo.yCFD.2.|roo.surf_surBou.1..Q_flow|roo.surf_surBou.2..Q_flow|roo.surf_surBou.1..T|roo.surf_surBou.2..T|roo.surf_surBou.3..T|roo.surf_surBou.4..T|roo.surf_surBou.5..T|roo.surf_surBou.6..T|conPID.u_s|conPID.u_m|conPID.y",fileNamePrefix="Buildings_11_Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl")
translateModel(Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|roo.yCFD.1.|roo.yCFD.2.|roo.surf_surBou.1..Q_flow|roo.surf_surBou.2..Q_flow|roo.surf_surBou.1..T|roo.surf_surBou.2..T|roo.surf_surBou.3..T|roo.surf_surBou.4..T|roo.surf_surBou.5..T|roo.surf_surBou.6..T|conPID.u_s|conPID.u_m|conPID.y",fileNamePrefix="Buildings_11_Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 2.124e-06/2.124e-06, allocations: 0 / 0.951 GB, free: 11.54 MB / 0.8575 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 3.148e-05/3.36e-05, allocations: 6.219 kB / 0.951 GB, free: 11.54 MB / 0.8575 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl): time 0.9054/0.9054, allocations: 179.7 MB / 1.127 GB, free: 12.51 MB / 0.9981 GB
Notification: Performance of NFInst.instExpressions: time 0.06792/0.9733, allocations: 31.58 MB / 1.157 GB, free: 12.05 MB / 0.9981 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02094/0.9942, allocations: 433.6 kB / 1.158 GB, free: 12.05 MB / 0.9981 GB
Notification: Performance of NFTyping.typeComponents: time 0.01205/1.006, allocations: 2.937 MB / 1.161 GB, free: 11.96 MB / 0.9981 GB
Notification: Performance of NFTyping.typeBindings: time 0.01278/1.019, allocations: 2.745 MB / 1.163 GB, free: 11.12 MB / 0.9981 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0104/1.029, allocations: 2.904 MB / 1.166 GB, free: 9.984 MB / 0.9981 GB
Notification: Performance of NFFlatten.flatten: time 0.0179/1.047, allocations: 11.76 MB / 1.178 GB, free: 4.484 MB / 0.9981 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00734/1.055, allocations: 3.34 MB / 1.181 GB, free: 2.926 MB / 0.9981 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01444/1.069, allocations: 4.809 MB / 1.186 GB, free: 0.9219 MB / 0.9981 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01138/1.081, allocations: 3.271 MB / 1.189 GB, free: 0 / 0.9981 GB
Notification: Performance of NFPackage.collectConstants: time 0.004088/1.085, allocations: 0.6106 MB / 1.189 GB, free: 0 / 0.9981 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.008702/1.093, allocations: 1.458 MB / 1.191 GB, free: 15.8 MB / 1.014 GB
Notification: Performance of NFScalarize.scalarize: time 0.005854/1.099, allocations: 2.037 MB / 1.193 GB, free: 14.68 MB / 1.014 GB
Notification: Performance of NFVerifyModel.verify: time 0.01169/1.111, allocations: 2.272 MB / 1.195 GB, free: 13.67 MB / 1.014 GB
Notification: Performance of NFConvertDAE.convert: time 0.0347/1.146, allocations: 12.3 MB / 1.207 GB, free: 8.762 MB / 1.014 GB
Notification: Performance of FrontEnd - DAE generated: time 6.543e-06/1.146, allocations: 2.969 kB / 1.207 GB, free: 8.762 MB / 1.014 GB
Notification: Performance of FrontEnd: time 1.553e-06/1.146, allocations: 0.7812 kB / 1.207 GB, free: 8.762 MB / 1.014 GB
Notification: Performance of Transformations before backend: time 0.0004389/1.146, allocations: 0 / 1.207 GB, free: 8.762 MB / 1.014 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 560
 * Number of variables: 560
Notification: Performance of Generate backend data structure: time 0.04469/1.191, allocations: 9.488 MB / 1.216 GB, free: 2.047 MB / 1.014 GB
Notification: Performance of prepare preOptimizeDAE: time 6.39e-05/1.191, allocations: 8.875 kB / 1.216 GB, free: 2.047 MB / 1.014 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008425/1.199, allocations: 1.012 MB / 1.217 GB, free: 1.512 MB / 1.014 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03037/1.23, allocations: 7.365 MB / 1.224 GB, free: 12.86 MB / 1.029 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004349/1.23, allocations: 202.1 kB / 1.225 GB, free: 12.77 MB / 1.029 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001738/1.232, allocations: 276.6 kB / 1.225 GB, free: 12.68 MB / 1.029 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01047/1.242, allocations: 3.514 MB / 1.228 GB, free: 10.16 MB / 1.029 GB
Notification: Performance of preOpt findStateOrder (simulation): time 8.713e-05/1.242, allocations: 14.19 kB / 1.228 GB, free: 10.16 MB / 1.029 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003898/1.243, allocations: 96.42 kB / 1.228 GB, free: 10.09 MB / 1.029 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001064/1.243, allocations: 85.33 kB / 1.229 GB, free: 10.08 MB / 1.029 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006013/1.249, allocations: 3.058 MB / 1.232 GB, free: 8.559 MB / 1.029 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.02976/1.279, allocations: 13.62 MB / 1.245 GB, free: 14.76 MB / 1.045 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005638/1.284, allocations: 2.406 MB / 1.247 GB, free: 13.5 MB / 1.045 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002445/1.287, allocations: 1.18 MB / 1.248 GB, free: 12.88 MB / 1.045 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001285/1.287, allocations: 39.62 kB / 1.248 GB, free: 12.87 MB / 1.045 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003025/1.29, allocations: 1.703 MB / 1.25 GB, free: 11.75 MB / 1.045 GB
Notification: Performance of pre-optimization done (n=195): time 4.618e-06/1.29, allocations: 0 / 1.25 GB, free: 11.75 MB / 1.045 GB
Notification: Performance of matching and sorting (n=195): time 0.01477/1.305, allocations: 5.071 MB / 1.255 GB, free: 7.992 MB / 1.045 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002342/1.305, allocations: 324.6 kB / 1.255 GB, free: 7.617 MB / 1.045 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0187/1.324, allocations: 9.69 MB / 1.265 GB, free: 13.94 MB / 1.061 GB
Notification: Performance of collectPreVariables (initialization): time 0.0008765/1.324, allocations: 117.7 kB / 1.265 GB, free: 13.82 MB / 1.061 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004173/1.329, allocations: 3.205 MB / 1.268 GB, free: 10.61 MB / 1.061 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001042/1.33, allocations: 0.6545 MB / 1.269 GB, free: 9.969 MB / 1.061 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001323/1.331, allocations: 0.7461 MB / 1.269 GB, free: 9.215 MB / 1.061 GB
Notification: Performance of setup shared object (initialization): time 0.0001416/1.331, allocations: 305.1 kB / 1.27 GB, free: 8.914 MB / 1.061 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00318/1.334, allocations: 1.776 MB / 1.271 GB, free: 7.125 MB / 1.061 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004452/1.339, allocations: 3.201 MB / 1.275 GB, free: 3.492 MB / 1.061 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006053/1.345, allocations: 3.754 MB / 1.278 GB, free: 15.51 MB / 1.076 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.884e-05/1.345, allocations: 4 kB / 1.278 GB, free: 15.51 MB / 1.076 GB
Notification: Performance of matching and sorting (n=442) (initialization): time 0.01277/1.358, allocations: 5.758 MB / 1.284 GB, free: 9.855 MB / 1.076 GB
Notification: Performance of prepare postOptimizeDAE: time 6.742e-05/1.358, allocations: 45.64 kB / 1.284 GB, free: 9.805 MB / 1.076 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.286e-05/1.358, allocations: 20.91 kB / 1.284 GB, free: 9.785 MB / 1.076 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002551/1.36, allocations: 0.6534 MB / 1.285 GB, free: 9.125 MB / 1.076 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005261/1.365, allocations: 0.9162 MB / 1.285 GB, free: 8.258 MB / 1.076 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02046/1.386, allocations: 14.25 MB / 1.299 GB, free: 9.27 MB / 1.092 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006319/1.392, allocations: 455.2 kB / 1.3 GB, free: 8.824 MB / 1.092 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008789/1.393, allocations: 144 kB / 1.3 GB, free: 8.684 MB / 1.092 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.008834/1.402, allocations: 4.107 MB / 1.304 GB, free: 4.562 MB / 1.092 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.004617/1.407, allocations: 3.178 MB / 1.307 GB, free: 0.957 MB / 1.092 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.006214/1.413, allocations: 3.711 MB / 1.311 GB, free: 13.02 MB / 1.107 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.191e-05/1.413, allocations: 8 kB / 1.311 GB, free: 13.01 MB / 1.107 GB
Notification: Performance of matching and sorting (n=442) (initialization_lambda0): time 0.01358/1.426, allocations: 5.699 MB / 1.316 GB, free: 7.418 MB / 1.107 GB
Notification: Performance of prepare postOptimizeDAE: time 6.326e-05/1.426, allocations: 45.73 kB / 1.316 GB, free: 7.367 MB / 1.107 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.887e-05/1.426, allocations: 20 kB / 1.316 GB, free: 7.348 MB / 1.107 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002567/1.429, allocations: 0.656 MB / 1.317 GB, free: 6.688 MB / 1.107 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003327/1.432, allocations: 0.6758 MB / 1.318 GB, free: 6.059 MB / 1.107 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009972/1.442, allocations: 5.989 MB / 1.323 GB, free: 15.88 MB / 1.123 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007369/1.45, allocations: 386.1 kB / 1.324 GB, free: 15.5 MB / 1.123 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001073/1.451, allocations: 148 kB / 1.324 GB, free: 15.36 MB / 1.123 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 98
 * Number of states: 0 ()
 * Number of discrete variables: 91 (roo.air.cfd.uIntPre[9],$PRE.roo.air.cfd.uIntPre[9],roo.air.cfd.uIntPre[8],$PRE.roo.air.cfd.uIntPre[8],roo.air.cfd.uIntPre[7],$PRE.roo.air.cfd.uIntPre[7],roo.air.cfd.uIntPre[6],$PRE.roo.air.cfd.uIntPre[6],roo.air.cfd.uIntPre[5],$PRE.roo.air.cfd.uIntPre[5],roo.air.cfd.uIntPre[4],$PRE.roo.air.cfd.uIntPre[4],roo.air.cfd.uIntPre[3],$PRE.roo.air.cfd.uIntPre[3],roo.air.cfd.uIntPre[2],$PRE.roo.air.cfd.uIntPre[2],roo.air.cfd.uIntPre[1],$PRE.roo.air.cfd.uIntPre[1],roo.air.cfd.firstTrigger,$PRE.roo.air.cfd.firstTrigger,roo.air.cfd.retVal,$PRE.roo.air.cfd.retVal,roo.air.cfd.modTimRea,$PRE.roo.air.cfd.modTimRea,roo.air.cfd.uWri[9],$PRE.roo.air.cfd.uWri[9],roo.air.cfd.uWri[2],$PRE.roo.air.cfd.uWri[2],roo.air.cfd.uWri[1],$PRE.roo.air.cfd.uWri[1],roo.air.cfd.sampleTrigger,$whenCondition1,$whenCondition2,roo.air.cfd.y[9],$PRE.roo.air.cfd.y[9],roo.air.cfd.y[7],$PRE.roo.air.cfd.y[7],weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,weaDat.decAng.k,$PRE.weaDat.decAng.k,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.k,$PRE.weaDat.eqnTim.k,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.k,$PRE.weaDat.conTim.k,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.k,$PRE.weaDat.conTimMin.k,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.k,$PRE.weaDat.locTim.k,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,roo.air.cfd.uWri[7],$PRE.roo.air.cfd.uWri[7],roo.air.cfd.y[8],$PRE.roo.air.cfd.y[8],roo.air.cfd.uWri[8],$PRE.roo.air.cfd.uWri[8],roo.air.cfd.uWri[6],$PRE.roo.air.cfd.uWri[6],roo.air.cfd.uWri[5],$PRE.roo.air.cfd.uWri[5],roo.air.cfd.uWri[4],$PRE.roo.air.cfd.uWri[4],roo.air.cfd.uWri[3],$PRE.roo.air.cfd.uWri[3],roo.air.cfd.y[6],$PRE.roo.air.cfd.y[6],roo.air.cfd.y[5],$PRE.roo.air.cfd.y[5],roo.air.cfd.y[4],$PRE.roo.air.cfd.y[4],roo.air.cfd.y[3],$PRE.roo.air.cfd.y[3],roo.air.cfd.y[2],$PRE.roo.air.cfd.y[2],roo.air.cfd.y[1],$PRE.roo.air.cfd.y[1],conPID.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (429):
 * Single equations (assignments): 420
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 2
 * 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): 6 systems
   {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): 1 system
   {(5,7,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.001325/1.452, allocations: 0.4929 MB / 1.324 GB, free: 14.91 MB / 1.123 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00274/1.455, allocations: 0.7216 MB / 1.325 GB, free: 14.18 MB / 1.123 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004958/1.46, allocations: 1.738 MB / 1.327 GB, free: 12.43 MB / 1.123 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.174e-05/1.46, allocations: 20 kB / 1.327 GB, free: 12.41 MB / 1.123 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.097e-05/1.46, allocations: 4 kB / 1.327 GB, free: 12.4 MB / 1.123 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.477e-05/1.46, allocations: 11.95 kB / 1.327 GB, free: 12.39 MB / 1.123 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02131/1.481, allocations: 7.868 MB / 1.335 GB, free: 4.512 MB / 1.123 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.022e-05/1.481, allocations: 0 / 1.335 GB, free: 4.512 MB / 1.123 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00341/1.485, allocations: 0.4989 MB / 1.335 GB, free: 4.027 MB / 1.123 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002422/1.487, allocations: 0.5948 MB / 1.336 GB, free: 3.426 MB / 1.123 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0003045/1.487, allocations: 59.95 kB / 1.336 GB, free: 3.367 MB / 1.123 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01754/1.505, allocations: 14.09 MB / 1.349 GB, free: 4.527 MB / 1.139 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.855e-06/1.505, allocations: 2.531 kB / 1.349 GB, free: 4.527 MB / 1.139 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01372/1.519, allocations: 5.694 MB / 1.355 GB, free: 14.81 MB / 1.154 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005067/1.524, allocations: 1.359 MB / 1.356 GB, free: 13.45 MB / 1.154 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002097/1.526, allocations: 100.1 kB / 1.356 GB, free: 13.35 MB / 1.154 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003585/1.529, allocations: 163.8 kB / 1.357 GB, free: 13.19 MB / 1.154 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000525/1.53, allocations: 144.3 kB / 1.357 GB, free: 13.05 MB / 1.154 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001857/1.53, allocations: 71.95 kB / 1.357 GB, free: 12.98 MB / 1.154 GB
Notification: Performance of sorting global known variables: time 0.01678/1.547, allocations: 6.735 MB / 1.363 GB, free: 6.27 MB / 1.154 GB
Notification: Performance of sort global known variables: time 4.81e-07/1.547, allocations: 0 / 1.363 GB, free: 6.27 MB / 1.154 GB
Notification: Performance of remove unused functions: time 0.01258/1.559, allocations: 2.407 MB / 1.366 GB, free: 3.859 MB / 1.154 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 2
 * Number of states: 11 (roo.air.cfd.uInt[1],roo.air.cfd.uInt[2],roo.air.cfd.uInt[3],roo.air.cfd.uInt[4],roo.air.cfd.uInt[5],roo.air.cfd.uInt[6],roo.air.cfd.uInt[7],roo.air.cfd.uInt[8],roo.air.cfd.uInt[9],roo.air.fluInt.p,conPID.I.y)
 * Number of discrete variables: 48 (roo.air.cfd.sampleTrigger,$whenCondition2,$whenCondition1,roo.air.cfd.firstTrigger,roo.air.cfd.y[1],roo.air.cfd.y[2],roo.air.cfd.y[3],roo.air.cfd.y[4],roo.air.cfd.y[5],roo.air.cfd.y[6],roo.air.cfd.y[7],roo.air.cfd.y[8],roo.air.cfd.y[9],roo.air.cfd.uIntPre[1],roo.air.cfd.uIntPre[2],roo.air.cfd.uIntPre[3],roo.air.cfd.uIntPre[4],roo.air.cfd.uIntPre[5],roo.air.cfd.uIntPre[6],roo.air.cfd.uIntPre[7],roo.air.cfd.uIntPre[8],roo.air.cfd.uIntPre[9],roo.air.cfd.uWri[1],roo.air.cfd.uWri[2],roo.air.cfd.uWri[3],roo.air.cfd.uWri[4],roo.air.cfd.uWri[5],roo.air.cfd.uWri[6],roo.air.cfd.uWri[7],roo.air.cfd.uWri[8],roo.air.cfd.uWri[9],roo.air.cfd.modTimRea,roo.air.cfd.retVal,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,weaDat.locTim.tNext,weaDat.locTim.k,weaDat.conTimMin.tNext,weaDat.conTimMin.k,weaDat.conTim.tNext,weaDat.conTim.k,weaDat.eqnTim.tNext,weaDat.eqnTim.k,weaDat.decAng.tNext,weaDat.decAng.k)
 * Number of discrete states: 39 (weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.locTim.tNext,weaDat.decAng.tNext,weaDat.conTimMin.tNext,weaDat.decAng.k,weaDat.eqnTim.k,weaDat.conTim.k,weaDat.conTimMin.k,weaDat.locTim.k,roo.air.cfd.u[1],roo.air.cfd.uIntPre[1],roo.air.cfd.u[2],roo.air.cfd.uIntPre[2],roo.air.cfd.u[3],roo.air.cfd.uIntPre[3],roo.air.cfd.u[4],roo.air.cfd.uIntPre[4],roo.air.cfd.u[5],roo.air.cfd.uIntPre[5],roo.air.cfd.u[6],roo.air.cfd.uIntPre[6],roo.air.cfd.u[7],roo.air.cfd.uIntPre[7],roo.air.cfd.uIntPre[8],roo.air.cfd.u[9],roo.air.cfd.uIntPre[9],roo.air.cfd.retVal,roo.air.cfd.y[9],roo.air.cfd.y[8],roo.air.cfd.y[7],roo.air.cfd.y[6],roo.air.cfd.y[5],roo.air.cfd.y[4],roo.air.cfd.y[3],roo.air.cfd.y[2],roo.air.cfd.y[1],roo.air.cfd.modTimRea,$whenCondition1)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (184):
 * Single equations (assignments): 146
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 29
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 2
 * 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): 6 systems
   {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): 1 system
   {(5,7,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.003609/1.563, allocations: 0.9871 MB / 1.367 GB, free: 3.16 MB / 1.154 GB
Notification: Performance of simCode: created initialization part: time 0.01903/1.582, allocations: 7.009 MB / 1.374 GB, free: 12.24 MB / 1.17 GB
Notification: Performance of simCode: created event and clocks part: time 7.815e-06/1.582, allocations: 0 / 1.374 GB, free: 12.24 MB / 1.17 GB
Notification: Performance of simCode: created simulation system equations: time 0.005735/1.588, allocations: 1.96 MB / 1.375 GB, free: 10.27 MB / 1.17 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0132/1.601, allocations: 2.347 MB / 1.378 GB, free: 8.02 MB / 1.17 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0286/1.63, allocations: 13.63 MB / 1.391 GB, free: 10.36 MB / 1.186 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00662/1.636, allocations: 4.229 MB / 1.395 GB, free: 6.082 MB / 1.186 GB
Notification: Performance of simCode: alias equations: time 0.006637/1.643, allocations: 1.857 MB / 1.397 GB, free: 4.223 MB / 1.186 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001791/1.645, allocations: 400.4 kB / 1.397 GB, free: 3.832 MB / 1.186 GB
Notification: Performance of SimCode: time 8.91e-07/1.645, allocations: 0 / 1.397 GB, free: 3.832 MB / 1.186 GB
Notification: Performance of Templates: time 0.2004/1.845, allocations: 105.5 MB / 1.5 GB, free: 11.85 MB / 1.295 GB
"
[Timeout remaining time 298]
make -j1 -f Buildings_11_Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl.makefile [Timeout 300]
(rm -f Buildings_11_Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl.pipe ; mkfifo Buildings_11_Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl.pipe ; head -c 1048576 < Buildings_11_Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl.pipe >> ../files/Buildings_11_Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl.sim & ./Buildings_11_Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_11_Buildings.ThermalZones.Detailed.Examples.FFD.NaturalConvectionWithControl.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 13.135087389498949]
Failed to read output from testmodel.py, exit status != 0:
1.8563594408333302 1.870736103 0.7210294939999999
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f19b45c51e0>