Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_7.0.0_Buildings.Examples.Tutorial.CDL.System3.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.1/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.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.1/package.mo)
Running command: translateModel(Buildings.Examples.Tutorial.CDL.System3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_7.0.0_Buildings.Examples.Tutorial.CDL.System3")
translateModel(Buildings.Examples.Tutorial.CDL.System3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_7.0.0_Buildings.Examples.Tutorial.CDL.System3")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.1/package.mo): time 2.232/2.232, allocations: 251.1 MB / 266.7 MB, free: 11.62 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.001341/0.00134, allocations: 176.4 kB / 326.3 MB, free: 2.852 MB / 250.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.351/2.351, allocations: 205.4 MB / 0.5772 GB, free: 20.77 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.000945/0.0009444, allocations: 88.62 kB / 0.6817 GB, free: 13.61 MB / 0.5105 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004849/0.000485, allocations: 16.16 kB / 0.7957 GB, free: 135.5 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.212/0.2125, allocations: 106.3 MB / 0.8995 GB, free: 65.51 MB / 0.6042 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.Tutorial.CDL.System3): time 1.352/1.565, allocations: 482.7 MB / 1.371 GB, free: 12.46 MB / 0.8855 GB
Notification: Performance of NFInst.instExpressions: time 0.9512/2.516, allocations: 69.05 MB / 1.438 GB, free: 20.77 MB / 0.9011 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01748/2.533, allocations: 362 kB / 1.439 GB, free: 20.77 MB / 0.9011 GB
Notification: Performance of NFTyping.typeComponents: time 0.01756/2.551, allocations: 3.558 MB / 1.442 GB, free: 20.71 MB / 0.9011 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.1/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.1/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.1/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.1/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.04565/2.597, allocations: 10.56 MB / 1.452 GB, free: 20.23 MB / 0.9011 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03948/2.636, allocations: 8.62 MB / 1.461 GB, free: 19.91 MB / 0.9011 GB
Notification: Performance of NFFlatten.flatten: time 0.0571/2.693, allocations: 35.46 MB / 1.495 GB, free: 19.84 MB / 0.9011 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02615/2.72, allocations: 9.403 MB / 1.505 GB, free: 18.05 MB / 0.9011 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02839/2.748, allocations: 9.285 MB / 1.514 GB, free: 16.64 MB / 0.9011 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02067/2.769, allocations: 8.11 MB / 1.522 GB, free: 13.44 MB / 0.9011 GB
Notification: Performance of NFPackage.collectConstants: time 0.004699/2.774, allocations: 420.1 kB / 1.522 GB, free: 13.44 MB / 0.9011 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02191/2.795, allocations: 3.935 MB / 1.526 GB, free: 12.39 MB / 0.9011 GB
Notification: Performance of NFScalarize.scalarize: time 0.006595/2.802, allocations: 2.352 MB / 1.528 GB, free: 11.3 MB / 0.9011 GB
Notification: Performance of NFVerifyModel.verify: time 0.007739/2.81, allocations: 2.409 MB / 1.531 GB, free: 10.87 MB / 0.9011 GB
Notification: Performance of NFConvertDAE.convert: time 0.02844/2.838, allocations: 14.75 MB / 1.545 GB, free: 2.902 MB / 0.9011 GB
Notification: Performance of FrontEnd - DAE generated: time 7.705e-06/2.838, allocations: 0 / 1.545 GB, free: 2.902 MB / 0.9011 GB
Notification: Performance of FrontEnd: time 2.394e-06/2.839, allocations: 0 / 1.545 GB, free: 2.902 MB / 0.9011 GB
Notification: Performance of Transformations before backend: time 0.0007141/2.839, allocations: 0 / 1.545 GB, free: 2.902 MB / 0.9011 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1856
 * Number of variables: 1856
Notification: Performance of Generate backend data structure: time 0.03882/2.878, allocations: 11.1 MB / 1.556 GB, free: 11.38 MB / 0.9167 GB
Notification: Performance of prepare preOptimizeDAE: time 5.362e-05/2.878, allocations: 8.031 kB / 1.556 GB, free: 11.37 MB / 0.9167 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01754/2.896, allocations: 2.077 MB / 1.558 GB, free: 9.297 MB / 0.9167 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03625/2.932, allocations: 9.916 MB / 1.567 GB, free: 2.41 MB / 0.9167 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0009005/2.933, allocations: 0.5768 MB / 1.568 GB, free: 2.074 MB / 0.9167 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003232/2.936, allocations: 0.773 MB / 1.569 GB, free: 1.551 MB / 0.9167 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03093/2.967, allocations: 8.587 MB / 1.577 GB, free: 11.38 MB / 0.9324 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003298/2.968, allocations: 19.78 kB / 1.577 GB, free: 11.36 MB / 0.9324 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001716/2.969, allocations: 307.3 kB / 1.578 GB, free: 11.29 MB / 0.9324 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004064/2.97, allocations: 292.6 kB / 1.578 GB, free: 11.02 MB / 0.9324 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02625/2.996, allocations: 7.038 MB / 1.585 GB, free: 6.227 MB / 0.9324 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.144/3.14, allocations: 41.35 MB / 1.625 GB, free: 2.406 MB / 0.9636 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01506/3.155, allocations: 4.636 MB / 1.63 GB, free: 15.27 MB / 0.9792 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.008652/3.164, allocations: 2.406 MB / 1.632 GB, free: 13.73 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 evalFunc (simulation): time 0.05845/3.222, allocations: 10.29 MB / 1.642 GB, free: 6 MB / 0.9792 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01377/3.236, allocations: 2.453 MB / 1.644 GB, free: 4.262 MB / 0.9792 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.008958/3.245, allocations: 465 kB / 1.645 GB, free: 3.875 MB / 0.9792 GB
Notification: Performance of pre-optimization done (n=402): time 2.701e-05/3.245, allocations: 0 / 1.645 GB, free: 3.875 MB / 0.9792 GB
Notification: Performance of matching and sorting (n=411): time 0.0743/3.32, allocations: 14.76 MB / 1.659 GB, free: 8.324 MB / 0.9949 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003342/3.32, allocations: 0.5703 MB / 1.66 GB, free: 7.625 MB / 0.9949 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02249/3.342, allocations: 8.203 MB / 1.668 GB, free: 1.699 MB / 0.9949 GB
Notification: Performance of collectPreVariables (initialization): time 0.001375/3.344, allocations: 130.8 kB / 1.668 GB, free: 1.637 MB / 0.9949 GB
Notification: Performance of collectInitialEqns (initialization): time 0.007438/3.351, allocations: 5.056 MB / 1.673 GB, free: 15.02 MB / 1.01 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002817/3.354, allocations: 1.429 MB / 1.674 GB, free: 13.8 MB / 1.01 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0008318/3.355, allocations: 112.1 kB / 1.674 GB, free: 13.78 MB / 1.01 GB
Notification: Performance of setup shared object (initialization): time 0.000524/3.356, allocations: 0.5233 MB / 1.675 GB, free: 13.34 MB / 1.01 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.008845/3.365, allocations: 2.164 MB / 1.677 GB, free: 11.91 MB / 1.01 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01116/3.376, allocations: 3.969 MB / 1.681 GB, free: 8.078 MB / 1.01 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01056/3.386, allocations: 2.754 MB / 1.684 GB, free: 6.336 MB / 1.01 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.664e-05/3.386, allocations: 8 kB / 1.684 GB, free: 6.328 MB / 1.01 GB
Notification: Performance of matching and sorting (n=730) (initialization): time 0.04566/3.432, allocations: 8.095 MB / 1.691 GB, free: 136 kB / 1.01 GB
Notification: Performance of prepare postOptimizeDAE: time 0.001742/3.434, allocations: 1.293 MB / 1.693 GB, free: 14.41 MB / 1.026 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002075/3.434, allocations: 44.94 kB / 1.693 GB, free: 14.36 MB / 1.026 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02688/3.461, allocations: 1.857 MB / 1.695 GB, free: 12.68 MB / 1.026 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01632/3.478, allocations: 1.239 MB / 1.696 GB, free: 11.48 MB / 1.026 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02067/3.498, allocations: 7.876 MB / 1.703 GB, free: 4.035 MB / 1.026 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01537/3.514, allocations: 0.7541 MB / 1.704 GB, free: 3.375 MB / 1.026 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001691/3.515, allocations: 279.8 kB / 1.704 GB, free: 3.148 MB / 1.026 GB
Notification: Performance of prepare postOptimizeDAE: time 1.44e-05/3.515, allocations: 4 kB / 1.704 GB, free: 3.145 MB / 1.026 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.03182/3.547, allocations: 6.936 MB / 1.711 GB, free: 14.17 MB / 1.042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001862/3.548, allocations: 47.98 kB / 1.711 GB, free: 14.12 MB / 1.042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01639/3.564, allocations: 1.715 MB / 1.713 GB, free: 12.57 MB / 1.042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009757/3.574, allocations: 1.176 MB / 1.714 GB, free: 11.43 MB / 1.042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02374/3.598, allocations: 9.783 MB / 1.724 GB, free: 2.742 MB / 1.042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01431/3.612, allocations: 0.7257 MB / 1.724 GB, free: 2.113 MB / 1.042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001594/3.614, allocations: 264.3 kB / 1.725 GB, free: 1.902 MB / 1.042 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 177
 * Number of states: 0 ()
 * Number of discrete variables: 14 ($whenCondition1,$PRE.timTab.tab.nextTimeEvent,$whenCondition3,$whenCondition2,timTab.tab.nextTimeEvent,$PRE.timTab.tab.nextTimeEventScaled,timTab.tab.nextTimeEventScaled,$PRE.weaDat.conTimMin.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTim.tNext,weaDat.conTimMin.canRepeatWeatherFile,weaDat.conTim.canRepeatWeatherFile,conBoiRet.conPID.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (665):
 * Single equations (assignments): 649
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 4
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 2 {(2,100.0%) 4,(1,100.0%) 4}
 * Non-linear torn systems: 3 {3 8,13 22,1 2}
Notification: Performance of prepare postOptimizeDAE: time 0.009216/3.623, allocations: 2.292 MB / 1.727 GB, free: 0.5547 MB / 1.042 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003994/3.627, allocations: 0.906 MB / 1.728 GB, free: 15.64 MB / 1.057 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02609/3.653, allocations: 6.139 MB / 1.734 GB, free: 10.86 MB / 1.057 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0194/3.672, allocations: 4.539 MB / 1.738 GB, free: 6.281 MB / 1.057 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.336e-05/3.672, allocations: 0 / 1.738 GB, free: 6.281 MB / 1.057 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008853/3.681, allocations: 1.649 MB / 1.74 GB, free: 4.602 MB / 1.057 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005545/3.687, allocations: 96 kB / 1.74 GB, free: 4.508 MB / 1.057 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01885/3.706, allocations: 0.6202 MB / 1.74 GB, free: 3.891 MB / 1.057 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001804/3.708, allocations: 323.1 kB / 1.741 GB, free: 3.574 MB / 1.057 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.04029/3.748, allocations: 5.748 MB / 1.746 GB, free: 13.87 MB / 1.073 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.03185/3.78, allocations: 7.803 MB / 1.754 GB, free: 6.012 MB / 1.073 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0068/3.787, allocations: 2.117 MB / 1.756 GB, free: 3.891 MB / 1.073 GB
Notification: Performance of sorting global known variables: time 0.01572/3.803, allocations: 5.408 MB / 1.761 GB, free: 14.52 MB / 1.089 GB
Notification: Performance of Backend: time 1.302e-06/3.803, allocations: 0 / 1.761 GB, free: 14.52 MB / 1.089 GB
Notification: Performance of simCode: created initialization part: time 0.05012/3.853, allocations: 11.26 MB / 1.772 GB, free: 3.688 MB / 1.089 GB
Notification: Performance of SimCode: time 0.1004/3.953, allocations: 25.42 MB / 1.797 GB, free: 10.33 MB / 1.12 GB
Notification: Performance of Templates: time 1.741/5.694, allocations: 197.5 MB / 1.99 GB, free: 383.2 MB / 1.12 GB
make -j1 -f Buildings_7.0.0_Buildings.Examples.Tutorial.CDL.System3.makefile
(rm -f Buildings_7.0.0_Buildings.Examples.Tutorial.CDL.System3.pipe ; mkfifo Buildings_7.0.0_Buildings.Examples.Tutorial.CDL.System3.pipe ; head -c 1048576 < Buildings_7.0.0_Buildings.Examples.Tutorial.CDL.System3.pipe >> ../files/Buildings_7.0.0_Buildings.Examples.Tutorial.CDL.System3.sim & ./Buildings_7.0.0_Buildings.Examples.Tutorial.CDL.System3 -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_7.0.0_Buildings.Examples.Tutorial.CDL.System3.pipe 2>&1)