Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Modelica_3.2.2_Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo)
Using package Modelica with version 3.2.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo)
Using package Complex with version 3.2.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo)
Running command: translateModel(Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Modelica_3.2.2_Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls")
translateModel(Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Modelica_3.2.2_Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo): time 0.001052/0.001052, allocations: 179.2 kB / 16.38 MB, free: 5.766 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo): time 1.368/1.368, allocations: 194.5 MB / 211.6 MB, free: 3.051 MB / 170.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo): time 0.00162/0.00162, allocations: 104.1 kB / 256.9 MB, free: 4.379 MB / 202.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000372/0.0003718, allocations: 12 kB / 310.6 MB, free: 14.94 MB / 266.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.0985/0.09889, allocations: 44.5 MB / 355.1 MB, free: 2.34 MB / 298.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 7.067/7.166, allocations: 3.686 GB / 4.032 GB, free: 4.117 MB / 410.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002043/7.166, allocations: 91.95 kB / 4.032 GB, free: 4.027 MB / 410.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Blocks/Sources.mo:2346:7-2347:66:writable] Warning: Unused input variable tableAvailable in function .Modelica.Blocks.Sources.CombiTimeTable$NumberOfPeople.getDerTableValue.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Blocks/Sources.mo:2312:7-2313:66:writable] Warning: Unused input variable tableAvailable in function .Modelica.Blocks.Sources.CombiTimeTable$NumberOfPeople.getTableValue.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Blocks/Sources.mo:2358:7-2359:66:writable] Warning: Unused input variable tableAvailable in function .Modelica.Blocks.Sources.CombiTimeTable$NumberOfPeople.getTableTimeTmin.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Blocks/Sources.mo:2369:7-2370:66:writable] Warning: Unused input variable tableAvailable in function .Modelica.Blocks.Sources.CombiTimeTable$NumberOfPeople.getTableTimeTmax.
Notification: Performance of FrontEnd - DAE generated: time 3.038/10.2, allocations: 0.8997 GB / 4.932 GB, free: 23.27 MB / 458.7 MB
Notification: Performance of FrontEnd: time 2.385e-06/10.2, allocations: 0 / 4.932 GB, free: 23.27 MB / 458.7 MB
Notification: Performance of Transformations before backend: time 0.0002262/10.2, allocations: 84.72 kB / 4.932 GB, free: 23.26 MB / 458.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 822
 * Number of variables: 822
Notification: Performance of Generate backend data structure: time 0.0206/10.22, allocations: 6.323 MB / 4.938 GB, free: 20.29 MB / 458.7 MB
Notification: Performance of prepare preOptimizeDAE: time 3.765e-05/10.22, allocations: 6.969 kB / 4.938 GB, free: 20.29 MB / 458.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002221/10.23, allocations: 413.8 kB / 4.939 GB, free: 20.11 MB / 458.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005875/10.23, allocations: 2.403 MB / 4.941 GB, free: 19.62 MB / 458.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002414/10.23, allocations: 357.6 kB / 4.941 GB, free: 19.48 MB / 458.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0009716/10.23, allocations: 309.5 kB / 4.942 GB, free: 19.48 MB / 458.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007722/10.24, allocations: 5.282 MB / 4.947 GB, free: 18.92 MB / 458.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 6.556e-05/10.24, allocations: 8.562 kB / 4.947 GB, free: 18.92 MB / 458.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003979/10.24, allocations: 126.9 kB / 4.947 GB, free: 18.92 MB / 458.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002122/10.24, allocations: 261.4 kB / 4.947 GB, free: 18.91 MB / 458.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007341/10.25, allocations: 5.616 MB / 4.953 GB, free: 18.88 MB / 458.7 MB
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.02409/10.27, allocations: 20.45 MB / 4.973 GB, free: 9.93 MB / 458.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.005002/10.28, allocations: 3.565 MB / 4.976 GB, free: 9.875 MB / 458.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.002063/10.28, allocations: 3.223 MB / 4.979 GB, free: 6.496 MB / 458.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0034/10.28, allocations: 2.563 MB / 4.982 GB, free: 6.32 MB / 458.7 MB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001287/10.29, allocations: 279.1 kB / 4.982 GB, free: 6.168 MB / 458.7 MB
Notification: Performance of pre-optimization done (n=316): time 4.829e-06/10.29, allocations: 0 / 4.982 GB, free: 6.168 MB / 458.7 MB
Notification: Performance of matching and sorting (n=376): time 0.1046/10.39, allocations: 33.79 MB / 5.015 GB, free: 18.73 MB / 474.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001565/10.39, allocations: 326.4 kB / 5.015 GB, free: 18.38 MB / 474.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002399/10.39, allocations: 1.86 MB / 5.017 GB, free: 17.33 MB / 474.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.00103/10.39, allocations: 101.1 kB / 5.017 GB, free: 17.23 MB / 474.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0008984/10.4, allocations: 1.311 MB / 5.019 GB, free: 16.04 MB / 474.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001501/10.4, allocations: 1.329 MB / 5.02 GB, free: 14.84 MB / 474.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003461/10.4, allocations: 88 kB / 5.02 GB, free: 14.76 MB / 474.7 MB
Notification: Performance of setup shared object (initialization): time 0.0003258/10.4, allocations: 483.3 kB / 5.02 GB, free: 14.33 MB / 474.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005277/10.4, allocations: 2.896 MB / 5.023 GB, free: 11.96 MB / 474.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006004/10.41, allocations: 3.9 MB / 5.027 GB, free: 8.242 MB / 474.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006309/10.42, allocations: 3.468 MB / 5.03 GB, free: 5.227 MB / 474.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.08e-05/10.42, allocations: 8 kB / 5.03 GB, free: 5.219 MB / 474.7 MB
Notification: Performance of matching and sorting (n=544) (initialization): time 0.2825/10.7, allocations: 10.25 MB / 5.04 GB, free: 34.93 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.001823/10.7, allocations: 11.12 MB / 5.051 GB, free: 23.27 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.006e-05/10.7, allocations: 26.81 kB / 5.051 GB, free: 23.27 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009477/10.71, allocations: 2.737 MB / 5.054 GB, free: 23.22 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004549/10.71, allocations: 0.9401 MB / 5.055 GB, free: 23.22 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008008/10.72, allocations: 6.705 MB / 5.062 GB, free: 20.12 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00587/10.73, allocations: 0.5338 MB / 5.062 GB, free: 20.12 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001395/10.73, allocations: 249.1 kB / 5.062 GB, free: 20.12 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.633e-05/10.73, allocations: 5.906 kB / 5.062 GB, free: 20.12 MB / 474.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01688/10.75, allocations: 8.782 MB / 5.071 GB, free: 19.86 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.657e-05/10.75, allocations: 29.66 kB / 5.071 GB, free: 19.86 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008669/10.75, allocations: 2.577 MB / 5.073 GB, free: 19.81 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004892/10.76, allocations: 0.9656 MB / 5.074 GB, free: 19.8 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007703/10.77, allocations: 6.57 MB / 5.081 GB, free: 16.7 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005255/10.77, allocations: 0.5198 MB / 5.081 GB, free: 16.7 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001325/10.77, allocations: 240.2 kB / 5.081 GB, free: 16.7 MB / 474.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 122
 * Number of states: 0 ()
 * Number of discrete variables: 16 (traceVolume.ind,traceDuctIn.ind,traceDuctOut.ind,$whenCondition1,$PRE.NumberOfPeople.nextTimeEvent,volume.regularFlow[1],volume.regularFlow[2],volume.regularFlow[3],volume.regularFlow[4],volume.inFlow[4],volume.inFlow[3],volume.inFlow[2],volume.inFlow[1],NumberOfPeople.nextTimeEvent,$PRE.NumberOfPeople.nextTimeEventScaled,NumberOfPeople.nextTimeEventScaled)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (499):
 * Single equations (assignments): 489
 * Array equations: 0
 * Algorithm blocks: 4
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 6
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 6 {2 6,2 6,1 6,2 6,2 6,2 6}
Notification: Performance of prepare postOptimizeDAE: time 0.003142/10.78, allocations: 1.098 MB / 5.083 GB, free: 16.52 MB / 474.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008642/10.78, allocations: 300 kB / 5.083 GB, free: 16.52 MB / 474.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01675/10.79, allocations: 8.668 MB / 5.091 GB, free: 16.24 MB / 474.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.184e-05/10.79, allocations: 41.44 kB / 5.091 GB, free: 16.24 MB / 474.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.539e-05/10.79, allocations: 0.9062 kB / 5.091 GB, free: 16.24 MB / 474.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01196/10.81, allocations: 6.753 MB / 5.098 GB, free: 15.86 MB / 474.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02568/10.83, allocations: 13.33 MB / 5.111 GB, free: 15.22 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.029e-05/10.83, allocations: 0 / 5.111 GB, free: 15.22 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003747/10.84, allocations: 0.7055 MB / 5.112 GB, free: 15.22 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.01116/10.85, allocations: 3.123 MB / 5.115 GB, free: 15.17 MB / 474.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001173/10.85, allocations: 185.1 kB / 5.115 GB, free: 15.17 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.006865/10.86, allocations: 6.313 MB / 5.121 GB, free: 12.07 MB / 474.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.088e-06/10.86, allocations: 1.781 kB / 5.121 GB, free: 12.07 MB / 474.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02002/10.88, allocations: 10.93 MB / 5.132 GB, free: 11.55 MB / 474.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.003103/10.88, allocations: 1.055 MB / 5.133 GB, free: 11.29 MB / 474.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0008772/10.88, allocations: 133.4 kB / 5.133 GB, free: 11.29 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003461/10.88, allocations: 419.2 kB / 5.133 GB, free: 11.29 MB / 474.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004387/10.88, allocations: 261.5 kB / 5.134 GB, free: 11.28 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004035/10.88, allocations: 181.8 kB / 5.134 GB, free: 11.28 MB / 474.7 MB
Notification: Performance of sorting global known variables: time 0.001806/10.89, allocations: 1.407 MB / 5.135 GB, free: 11.14 MB / 474.7 MB
Notification: Performance of sort global known variables: time 3.31e-07/10.89, allocations: 1.438 kB / 5.135 GB, free: 11.14 MB / 474.7 MB
Notification: Performance of remove unused functions: time 0.01204/10.9, allocations: 3.251 MB / 5.138 GB, free: 11.14 MB / 474.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 6
 * Number of states: 21 (volume.medium.p,volume.medium.Xi[1],volume.medium.T,volume.mC_scaled[1],ductOut.mCs_scaled[1,1],ductOut.mCs_scaled[2,1],ductOut.mediums[1].p,ductOut.mediums[1].Xi[1],ductOut.mediums[1].T,ductOut.mediums[2].p,ductOut.mediums[2].Xi[1],ductOut.mediums[2].T,PID.I.y,ductIn.mCs_scaled[1,1],ductIn.mCs_scaled[2,1],ductIn.mediums[1].p,ductIn.mediums[1].Xi[1],ductIn.mediums[1].T,ductIn.mediums[2].p,ductIn.mediums[2].Xi[1],ductIn.mediums[2].T)
 * Number of discrete variables: 3 ($whenCondition1,NumberOfPeople.nextTimeEvent,NumberOfPeople.nextTimeEventScaled)
 * Number of discrete states: 2 (NumberOfPeople.nextTimeEvent,NumberOfPeople.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (373):
 * Single equations (assignments): 361
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 4
 * When equations: 2
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 6
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 6 {2 6,2 6,1 7,2 6,2 6,2 6}
Notification: Performance of Backend phase and start with SimCode phase: time 0.009372/10.91, allocations: 3.306 MB / 5.141 GB, free: 10.7 MB / 474.7 MB
Notification: Performance of simCode: created initialization part: time 0.0214/10.93, allocations: 11.43 MB / 5.153 GB, free: 10.08 MB / 474.7 MB
Notification: Performance of simCode: created event and clocks part: time 1.283e-05/10.93, allocations: 4.125 kB / 5.153 GB, free: 10.08 MB / 474.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.006332/10.94, allocations: 3.455 MB / 5.156 GB, free: 10.04 MB / 474.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00606/10.94, allocations: 1.324 MB / 5.157 GB, free: 9.988 MB / 474.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01776/10.96, allocations: 11.55 MB / 5.169 GB, free: 5.863 MB / 474.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001984/10.96, allocations: 2.463 MB / 5.171 GB, free: 20.89 MB / 490.7 MB
Notification: Performance of simCode: alias equations: time 0.007399/10.97, allocations: 2.535 MB / 5.173 GB, free: 20.66 MB / 490.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001249/10.97, allocations: 357.1 kB / 5.174 GB, free: 20.62 MB / 490.7 MB
Notification: Performance of SimCode: time 7.81e-07/10.97, allocations: 0 / 5.174 GB, free: 20.62 MB / 490.7 MB
Notification: Performance of Templates: time 0.4052/11.38, allocations: 122.5 MB / 5.293 GB, free: 44.47 MB / 490.7 MB
make -j1 -f Modelica_3.2.2_Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls.makefile
(rm -f Modelica_3.2.2_Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls.pipe ; mkfifo Modelica_3.2.2_Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls.pipe ; head -c 1048576 < Modelica_3.2.2_Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls.pipe >> ../files/Modelica_3.2.2_Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls.sim & ./Modelica_3.2.2_Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Modelica_3.2.2_Modelica.Fluid.Examples.TraceSubstances.RoomCO2WithControls.pipe 2>&1)