Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_maint.8.0.x_Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.1-maint.8.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 8.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.1-maint.8.0.x/package.mo)
Running command: translateModel(Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_maint.8.0.x_Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance")
translateModel(Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_maint.8.0.x_Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.1-maint.8.0.x/package.mo): time 1.485/1.485, allocations: 288.4 MB / 304.3 MB, free: 8.141 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.0009266/0.0009267, allocations: 172.6 kB / 372.9 MB, free: 10.14 MB / 298.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.239/1.239, allocations: 205.4 MB / 0.6316 GB, free: 9.883 MB / 458.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0006691/0.0006692, allocations: 104.6 kB / 0.745 GB, free: 5.793 MB / 0.5573 GB
Notification: Performance of FrontEnd - loaded program: time 0.0003491/0.0003492, allocations: 16.12 kB / 0.8681 GB, free: 141.8 MB / 0.6198 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1788/0.1792, allocations: 115.3 MB / 0.9807 GB, free: 27.36 MB / 0.6198 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance): time 0.5361/0.7153, allocations: 183.7 MB / 1.16 GB, free: 4.047 MB / 0.698 GB
Notification: Performance of NFInst.instExpressions: time 0.02127/0.7367, allocations: 13.85 MB / 1.174 GB, free: 8.773 MB / 0.7136 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004344/0.741, allocations: 79.12 kB / 1.174 GB, free: 8.746 MB / 0.7136 GB
Notification: Performance of NFTyping.typeComponents: time 0.002928/0.744, allocations: 1.089 MB / 1.175 GB, free: 7.996 MB / 0.7136 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.1-maint.8.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 8.0.1-maint.8.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 8.0.1-maint.8.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 8.0.1-maint.8.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.006657/0.7507, allocations: 2.238 MB / 1.177 GB, free: 6.332 MB / 0.7136 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004601/0.7553, allocations: 1.553 MB / 1.178 GB, free: 5.219 MB / 0.7136 GB
Notification: Performance of NFFlatten.flatten: time 0.008166/0.7635, allocations: 6.517 MB / 1.185 GB, free: 1.293 MB / 0.7136 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.005688/0.7692, allocations: 4.461 MB / 1.189 GB, free: 14.7 MB / 0.7292 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003515/0.7727, allocations: 1.797 MB / 1.191 GB, free: 13.77 MB / 0.7292 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00418/0.7769, allocations: 2.372 MB / 1.193 GB, free: 12.41 MB / 0.7292 GB
Notification: Performance of NFPackage.collectConstants: time 0.0008439/0.7778, allocations: 160.4 kB / 1.193 GB, free: 12.4 MB / 0.7292 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00382/0.7816, allocations: 1.579 MB / 1.195 GB, free: 11.62 MB / 0.7292 GB
Notification: Performance of NFScalarize.scalarize: time 0.001027/0.7827, allocations: 1.066 MB / 1.196 GB, free: 10.91 MB / 0.7292 GB
Notification: Performance of NFVerifyModel.verify: time 0.002389/0.7851, allocations: 1.956 MB / 1.198 GB, free: 9.562 MB / 0.7292 GB
Notification: Performance of NFConvertDAE.convert: time 0.00566/0.7908, allocations: 5.738 MB / 1.203 GB, free: 5.535 MB / 0.7292 GB
Notification: Performance of FrontEnd - DAE generated: time 6.742e-06/0.7908, allocations: 0 / 1.203 GB, free: 5.535 MB / 0.7292 GB
Notification: Performance of FrontEnd: time 2.114e-06/0.7908, allocations: 0 / 1.203 GB, free: 5.535 MB / 0.7292 GB
Notification: Performance of Transformations before backend: time 0.0002169/0.791, allocations: 0 / 1.203 GB, free: 5.535 MB / 0.7292 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1031
 * Number of variables: 1031
Notification: Performance of Generate backend data structure: time 0.01006/0.8011, allocations: 4.712 MB / 1.208 GB, free: 1.617 MB / 0.7292 GB
Notification: Performance of prepare preOptimizeDAE: time 4.564e-05/0.8012, allocations: 11.97 kB / 1.208 GB, free: 1.605 MB / 0.7292 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01338/0.8145, allocations: 2.92 MB / 1.211 GB, free: 14.68 MB / 0.7448 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005051/0.8196, allocations: 2.667 MB / 1.214 GB, free: 11.93 MB / 0.7448 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002019/0.8199, allocations: 304.1 kB / 1.214 GB, free: 11.63 MB / 0.7448 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0007147/0.8206, allocations: 403.9 kB / 1.214 GB, free: 11.24 MB / 0.7448 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01243/0.833, allocations: 6.072 MB / 1.22 GB, free: 5.066 MB / 0.7448 GB
Notification: Performance of preOpt findStateOrder (simulation): time 7.045e-05/0.8331, allocations: 4 kB / 1.22 GB, free: 5.062 MB / 0.7448 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003769/0.8335, allocations: 164 kB / 1.22 GB, free: 4.902 MB / 0.7448 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001038/0.8336, allocations: 135.8 kB / 1.22 GB, free: 4.77 MB / 0.7448 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01567/0.8493, allocations: 7.16 MB / 1.227 GB, free: 13.6 MB / 0.7605 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.03191/0.8813, allocations: 18.66 MB / 1.246 GB, free: 10.2 MB / 0.7761 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.009299/0.8906, allocations: 4.822 MB / 1.25 GB, free: 5.371 MB / 0.7761 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005813/0.8965, allocations: 3.221 MB / 1.254 GB, free: 2.141 MB / 0.7761 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0009182/0.8974, allocations: 0.6975 MB / 1.254 GB, free: 1.312 MB / 0.7761 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.005437/0.9029, allocations: 2.83 MB / 1.257 GB, free: 14.45 MB / 0.7917 GB
Notification: Performance of pre-optimization done (n=343): time 7.914e-06/0.9029, allocations: 0 / 1.257 GB, free: 14.45 MB / 0.7917 GB
Notification: Performance of matching and sorting (n=345): time 0.03771/0.9406, allocations: 15.8 MB / 1.272 GB, free: 14.45 MB / 0.8073 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001049/0.9408, allocations: 222.6 kB / 1.273 GB, free: 14.19 MB / 0.8073 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003633/0.9444, allocations: 2.87 MB / 1.275 GB, free: 11.3 MB / 0.8073 GB
Notification: Performance of collectPreVariables (initialization): time 0.0006698/0.9451, allocations: 89.7 kB / 1.275 GB, free: 11.21 MB / 0.8073 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001408/0.9465, allocations: 1.649 MB / 1.277 GB, free: 9.543 MB / 0.8073 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001258/0.9478, allocations: 1.147 MB / 1.278 GB, free: 8.379 MB / 0.8073 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002041/0.948, allocations: 63.94 kB / 1.278 GB, free: 8.316 MB / 0.8073 GB
Notification: Performance of setup shared object (initialization): time 0.0002012/0.9482, allocations: 428.2 kB / 1.279 GB, free: 7.891 MB / 0.8073 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004819/0.953, allocations: 2.254 MB / 1.281 GB, free: 5.633 MB / 0.8073 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005043/0.9581, allocations: 2.603 MB / 1.283 GB, free: 2.965 MB / 0.8073 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: thermalZoneFourElements.volAir.dynBal.medium.p = thermalZoneFourElements.volAir.dynBal.p_start (sinAir.p = thermalZoneFourElements.volAir.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.2861/1.244, allocations: 64.93 MB / 1.347 GB, free: 1.848 MB / 0.8698 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.39e-06/1.244, allocations: 4 kB / 1.347 GB, free: 1.844 MB / 0.8698 GB
Notification: Performance of matching and sorting (n=384) (initialization): time 0.01264/1.257, allocations: 6.03 MB / 1.353 GB, free: 11.76 MB / 0.8855 GB
Notification: Performance of prepare postOptimizeDAE: time 5.657e-05/1.257, allocations: 37.69 kB / 1.353 GB, free: 11.72 MB / 0.8855 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.533e-05/1.257, allocations: 4 kB / 1.353 GB, free: 11.71 MB / 0.8855 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00164/1.259, allocations: 0.8241 MB / 1.354 GB, free: 10.89 MB / 0.8855 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004143/1.263, allocations: 0.8307 MB / 1.354 GB, free: 10.06 MB / 0.8855 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009184/1.272, allocations: 6.936 MB / 1.361 GB, free: 2.984 MB / 0.8855 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00444/1.276, allocations: 459.2 kB / 1.362 GB, free: 2.535 MB / 0.8855 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005005/1.277, allocations: 131.8 kB / 1.362 GB, free: 2.406 MB / 0.8855 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization sytem:
         thermalZoneFourElements.volAir.dynBal.medium.p = thermalZoneFourElements.volAir.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 12
 * Number of states: 0 ()
 * Number of discrete variables: 18 ($whenCondition2,$PRE.intGai.nextTimeEvent,$PRE.traSub.T_start,$PRE.traSub.count,weaDat.conTimMin.canRepeatWeatherFile,weaDat.conTim.canRepeatWeatherFile,$whenCondition4,$whenCondition3,$whenCondition1,$PRE.weaDat.conTimMin.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTim.tNext,intGai.nextTimeEvent,$PRE.intGai.nextTimeEventScaled,intGai.nextTimeEventScaled,traSub.T_start,traSub.count)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (319):
 * Single equations (assignments): 317
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(5,100.0%) 60}
 * Non-linear torn systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.002226/1.279, allocations: 1.135 MB / 1.363 GB, free: 1.262 MB / 0.8855 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005771/1.28, allocations: 339.8 kB / 1.363 GB, free: 0.9258 MB / 0.8855 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0132/1.293, allocations: 6.575 MB / 1.37 GB, free: 10.29 MB / 0.9011 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01072/1.304, allocations: 5.733 MB / 1.375 GB, free: 4.438 MB / 0.9011 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.436e-06/1.304, allocations: 0 / 1.375 GB, free: 4.438 MB / 0.9011 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001977/1.306, allocations: 0.9377 MB / 1.376 GB, free: 3.477 MB / 0.9011 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004684/1.306, allocations: 71.98 kB / 1.376 GB, free: 3.406 MB / 0.9011 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003018/1.309, allocations: 447.2 kB / 1.377 GB, free: 2.969 MB / 0.9011 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004812/1.31, allocations: 266.4 kB / 1.377 GB, free: 2.707 MB / 0.9011 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01475/1.325, allocations: 6.465 MB / 1.383 GB, free: 12.2 MB / 0.9167 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.01676/1.341, allocations: 8.949 MB / 1.392 GB, free: 3.188 MB / 0.9167 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.005111/1.346, allocations: 2.637 MB / 1.394 GB, free: 0.5391 MB / 0.9167 GB
Notification: Performance of sorting global known variables: time 0.00322/1.35, allocations: 2.055 MB / 1.396 GB, free: 14.48 MB / 0.9323 GB
Notification: Performance of Backend: time 7.02e-07/1.35, allocations: 0 / 1.396 GB, free: 14.48 MB / 0.9323 GB
Notification: Performance of simCode: created initialization part: time 0.01219/1.362, allocations: 4.838 MB / 1.401 GB, free: 9.914 MB / 0.9323 GB
Notification: Performance of SimCode: time 0.01533/1.377, allocations: 10.45 MB / 1.411 GB, free: 15.43 MB / 0.948 GB
Notification: Performance of Templates: time 0.4541/1.831, allocations: 67.98 MB / 1.478 GB, free: 327.3 MB / 0.948 GB
make -j1 -f Buildings_maint.8.0.x_Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance.makefile
(rm -f Buildings_maint.8.0.x_Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance.pipe ; mkfifo Buildings_maint.8.0.x_Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance.pipe ; head -c 1048576 < Buildings_maint.8.0.x_Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance.pipe >> ../files/Buildings_maint.8.0.x_Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance.sim & ./Buildings_maint.8.0.x_Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_maint.8.0.x_Buildings.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElementsTraceSubstance.pipe 2>&1)