Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_maint.7.0.x_Buildings.Examples.Tutorial.CDL.System1.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+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/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/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 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 7.0.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo)
Running command: translateModel(Buildings.Examples.Tutorial.CDL.System1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_maint.7.0.x_Buildings.Examples.Tutorial.CDL.System1")
translateModel(Buildings.Examples.Tutorial.CDL.System1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_maint.7.0.x_Buildings.Examples.Tutorial.CDL.System1")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo): time 1.301/1.301, allocations: 251.5 MB / 267.4 MB, free: 11.05 MB / 218.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001049/0.001049, allocations: 171.2 kB / 326.5 MB, free: 2.684 MB / 250.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.641/1.641, allocations: 205 MB / 0.5767 GB, free: 21.02 MB / 426.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0007723/0.0007722, allocations: 78.36 kB / 0.6804 GB, free: 14.71 MB / 0.5105 GB
Notification: Performance of FrontEnd - loaded program: time 0.0003166/0.0003168, allocations: 8.812 kB / 0.7938 GB, free: 136.4 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2096/0.2099, allocations: 105.4 MB / 0.8967 GB, free: 68.18 MB / 0.6042 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.Tutorial.CDL.System1): time 1.535/1.745, allocations: 0.5067 GB / 1.403 GB, free: 18.16 MB / 0.9011 GB
Notification: Performance of NFInst.instExpressions: time 0.1026/1.847, allocations: 73.58 MB / 1.475 GB, free: 17.02 MB / 0.9011 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02035/1.868, allocations: 373.7 kB / 1.476 GB, free: 17.02 MB / 0.9011 GB
Notification: Performance of NFTyping.typeComponents: time 0.01639/1.884, allocations: 4.227 MB / 1.48 GB, free: 16.93 MB / 0.9011 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/BoundaryConditions/WeatherData/BaseClasses/getHeaderElementTMY3.mo:2:1-105:25:writable] Warning: Pure function ‘Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3‘ contains a call to impure function ‘Modelica.Utilities.Streams.readLine‘.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/BoundaryConditions/WeatherData/BaseClasses/getLongitudeTMY3.mo:2:1-48:21:writable] Warning: Pure function ‘Buildings.BoundaryConditions.WeatherData.BaseClasses.getLongitudeTMY3‘ contains a call to impure function ‘Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3‘.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/BoundaryConditions/WeatherData/BaseClasses/getLatitudeTMY3.mo:2:1-48:20:writable] Warning: Pure function ‘Buildings.BoundaryConditions.WeatherData.BaseClasses.getLatitudeTMY3‘ contains a call to impure function ‘Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3‘.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/BoundaryConditions/WeatherData/BaseClasses/getTimeZoneTMY3.mo:2:1-47:20:writable] Warning: Pure function ‘Buildings.BoundaryConditions.WeatherData.BaseClasses.getTimeZoneTMY3‘ contains a call to impure function ‘Buildings.BoundaryConditions.WeatherData.BaseClasses.getHeaderElementTMY3‘.
Notification: Performance of NFTyping.typeBindings: time 0.04297/1.927, allocations: 12.37 MB / 1.492 GB, free: 16.38 MB / 0.9011 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03073/1.958, allocations: 10.47 MB / 1.502 GB, free: 15.93 MB / 0.9011 GB
Notification: Performance of NFFlatten.flatten: time 0.04541/2.003, allocations: 41.15 MB / 1.542 GB, free: 8.902 MB / 0.9011 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01781/2.021, allocations: 9.489 MB / 1.552 GB, free: 3.816 MB / 0.9011 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03004/2.051, allocations: 9.714 MB / 1.561 GB, free: 0.8555 MB / 0.9011 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01877/2.07, allocations: 8.529 MB / 1.569 GB, free: 10.21 MB / 0.9167 GB
Notification: Performance of NFPackage.collectConstants: time 0.003936/2.074, allocations: 412 kB / 1.57 GB, free: 9.809 MB / 0.9167 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02117/2.095, allocations: 5.573 MB / 1.575 GB, free: 4.598 MB / 0.9167 GB
Notification: Performance of NFScalarize.scalarize: time 0.005943/2.101, allocations: 2.426 MB / 1.578 GB, free: 2.238 MB / 0.9167 GB
Notification: Performance of NFVerifyModel.verify: time 0.01601/2.117, allocations: 5.716 MB / 1.583 GB, free: 12.55 MB / 0.9323 GB
Notification: Performance of NFConvertDAE.convert: time 0.03515/2.152, allocations: 18.2 MB / 1.601 GB, free: 10.99 MB / 0.948 GB
Notification: Performance of FrontEnd - DAE generated: time 5.29e-06/2.152, allocations: 0 / 1.601 GB, free: 10.99 MB / 0.948 GB
Notification: Performance of FrontEnd: time 2.675e-06/2.152, allocations: 0 / 1.601 GB, free: 10.99 MB / 0.948 GB
Notification: Performance of Transformations before backend: time 0.0006095/2.153, allocations: 4 kB / 1.601 GB, free: 10.99 MB / 0.948 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1796
 * Number of variables: 1796
Notification: Performance of Generate backend data structure: time 0.02382/2.177, allocations: 10.74 MB / 1.611 GB, free: 248 kB / 0.948 GB
Notification: Performance of prepare preOptimizeDAE: time 5.585e-05/2.177, allocations: 8.031 kB / 1.611 GB, free: 240 kB / 0.948 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01101/2.188, allocations: 2.048 MB / 1.613 GB, free: 14.18 MB / 0.9636 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0217/2.21, allocations: 10.14 MB / 1.623 GB, free: 4.234 MB / 0.9636 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005097/2.21, allocations: 0.5499 MB / 1.624 GB, free: 3.688 MB / 0.9636 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001634/2.212, allocations: 0.7457 MB / 1.625 GB, free: 2.945 MB / 0.9636 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01689/2.229, allocations: 8.397 MB / 1.633 GB, free: 10.23 MB / 0.9792 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001546/2.229, allocations: 27.77 kB / 1.633 GB, free: 10.21 MB / 0.9792 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0006947/2.23, allocations: 300.8 kB / 1.633 GB, free: 9.918 MB / 0.9792 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002296/2.23, allocations: 281.4 kB / 1.633 GB, free: 9.641 MB / 0.9792 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01335/2.243, allocations: 6.907 MB / 1.64 GB, free: 2.719 MB / 0.9792 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.06946/2.313, allocations: 40.36 MB / 1.679 GB, free: 7.891 MB / 1.026 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.008467/2.321, allocations: 4.657 MB / 1.684 GB, free: 3.148 MB / 1.026 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004035/2.325, allocations: 2.332 MB / 1.686 GB, free: 0.8203 MB / 1.026 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 evalFunc (simulation): time 0.0245/2.35, allocations: 10.11 MB / 1.696 GB, free: 6.32 MB / 1.042 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004544/2.354, allocations: 2.391 MB / 1.699 GB, free: 3.887 MB / 1.042 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004575/2.359, allocations: 450 kB / 1.699 GB, free: 3.445 MB / 1.042 GB
Notification: Performance of pre-optimization done (n=390): time 1.713e-05/2.359, allocations: 8 kB / 1.699 GB, free: 3.438 MB / 1.042 GB
Notification: Performance of matching and sorting (n=399): time 0.04141/2.401, allocations: 14.58 MB / 1.713 GB, free: 4.582 MB / 1.057 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002513/2.401, allocations: 0.5519 MB / 1.714 GB, free: 3.906 MB / 1.057 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01702/2.418, allocations: 8.124 MB / 1.722 GB, free: 11.8 MB / 1.073 GB
Notification: Performance of collectPreVariables (initialization): time 0.001159/2.419, allocations: 121.7 kB / 1.722 GB, free: 11.67 MB / 1.073 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005141/2.424, allocations: 4.912 MB / 1.727 GB, free: 6.75 MB / 1.073 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002045/2.426, allocations: 1.388 MB / 1.728 GB, free: 5.371 MB / 1.073 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0008207/2.427, allocations: 481.8 kB / 1.728 GB, free: 4.898 MB / 1.073 GB
Notification: Performance of setup shared object (initialization): time 9.357e-05/2.427, allocations: 301.1 kB / 1.729 GB, free: 4.602 MB / 1.073 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004554/2.432, allocations: 2.217 MB / 1.731 GB, free: 2.379 MB / 1.073 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006122/2.438, allocations: 3.985 MB / 1.735 GB, free: 13.64 MB / 1.089 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01017/2.448, allocations: 5.811 MB / 1.74 GB, free: 7.223 MB / 1.089 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.088e-05/2.448, allocations: 12 kB / 1.74 GB, free: 7.211 MB / 1.089 GB
Notification: Performance of matching and sorting (n=711) (initialization): time 0.02627/2.474, allocations: 8.154 MB / 1.748 GB, free: 14.95 MB / 1.104 GB
Notification: Performance of prepare postOptimizeDAE: time 0.001088/2.476, allocations: 1.279 MB / 1.75 GB, free: 13.12 MB / 1.104 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.572e-05/2.476, allocations: 47.98 kB / 1.75 GB, free: 13.07 MB / 1.104 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0126/2.488, allocations: 1.888 MB / 1.752 GB, free: 11.18 MB / 1.104 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006126/2.494, allocations: 1.205 MB / 1.753 GB, free: 9.969 MB / 1.104 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01227/2.507, allocations: 8.099 MB / 1.761 GB, free: 1.402 MB / 1.104 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01028/2.517, allocations: 0.7408 MB / 1.761 GB, free: 0.668 MB / 1.104 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001273/2.518, allocations: 267.9 kB / 1.762 GB, free: 416 kB / 1.104 GB
Notification: Performance of prepare postOptimizeDAE: time 1.134e-05/2.518, allocations: 6.031 kB / 1.762 GB, free: 412 kB / 1.104 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01863/2.537, allocations: 6.862 MB / 1.768 GB, free: 9.441 MB / 1.12 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001238/2.537, allocations: 47.94 kB / 1.768 GB, free: 9.395 MB / 1.12 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008395/2.546, allocations: 1.719 MB / 1.77 GB, free: 7.664 MB / 1.12 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004985/2.551, allocations: 1.166 MB / 1.771 GB, free: 6.496 MB / 1.12 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01652/2.567, allocations: 10 MB / 1.781 GB, free: 11.95 MB / 1.135 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009117/2.576, allocations: 0.7035 MB / 1.782 GB, free: 11.25 MB / 1.135 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001341/2.578, allocations: 255.9 kB / 1.782 GB, free: 11 MB / 1.135 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 175
 * Number of states: 0 ()
 * Number of discrete variables: 13 ($PRE.timTab.tab.nextTimeEvent,$whenCondition1,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,timTab.tab.nextTimeEventScaled,$PRE.timTab.tab.nextTimeEventScaled,timTab.tab.nextTimeEvent,$whenCondition2,$whenCondition3)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (646):
 * Single equations (assignments): 630
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 4
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 5
 * 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): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(2,4,100.0%), (1,4,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(5,6), (13,22), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.006517/2.584, allocations: 2.26 MB / 1.784 GB, free: 8.723 MB / 1.135 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003515/2.588, allocations: 0.8912 MB / 1.785 GB, free: 7.82 MB / 1.135 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01518/2.603, allocations: 6.024 MB / 1.791 GB, free: 1.746 MB / 1.135 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.7211/3.324, allocations: 4.451 MB / 1.795 GB, free: 0.5391 GB / 1.136 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.344e-05/3.324, allocations: 0 / 1.795 GB, free: 0.5391 GB / 1.136 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005245/3.329, allocations: 1.488 MB / 1.797 GB, free: 0.5391 GB / 1.136 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002679/3.332, allocations: 96.45 kB / 1.797 GB, free: 0.5391 GB / 1.136 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.007397/3.34, allocations: 0.6167 MB / 1.797 GB, free: 0.5391 GB / 1.136 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0009367/3.341, allocations: 309.6 kB / 1.798 GB, free: 0.539 GB / 1.136 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01414/3.355, allocations: 5.648 MB / 1.803 GB, free: 0.5388 GB / 1.136 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.01505/3.37, allocations: 7.657 MB / 1.811 GB, free: 0.5376 GB / 1.136 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003571/3.373, allocations: 2.072 MB / 1.813 GB, free: 0.5369 GB / 1.136 GB
Notification: Performance of sorting global known variables: time 0.009395/3.383, allocations: 5.393 MB / 1.818 GB, free: 0.5351 GB / 1.136 GB
Notification: Performance of Backend: time 1.012e-06/3.383, allocations: 0 / 1.818 GB, free: 0.5351 GB / 1.136 GB
Notification: Performance of simCode: created initialization part: time 0.0318/3.415, allocations: 11.57 MB / 1.829 GB, free: 0.5314 GB / 1.136 GB
Notification: Performance of SimCode: time 0.04293/3.458, allocations: 25.57 MB / 1.854 GB, free: 0.5188 GB / 1.136 GB
Notification: Performance of Templates: time 0.2624/3.72, allocations: 198.9 MB / 2.048 GB, free: 337.1 MB / 1.136 GB
make -j1 -f Buildings_maint.7.0.x_Buildings.Examples.Tutorial.CDL.System1.makefile
(rm -f Buildings_maint.7.0.x_Buildings.Examples.Tutorial.CDL.System1.pipe ; mkfifo Buildings_maint.7.0.x_Buildings.Examples.Tutorial.CDL.System1.pipe ; head -c 1048576 < Buildings_maint.7.0.x_Buildings.Examples.Tutorial.CDL.System1.pipe >> ../files/Buildings_maint.7.0.x_Buildings.Examples.Tutorial.CDL.System1.sim & ./Buildings_maint.7.0.x_Buildings.Examples.Tutorial.CDL.System1 -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_maint.7.0.x_Buildings.Examples.Tutorial.CDL.System1.pipe 2>&1)