Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo", uses=false)
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements,tolerance=1e-06,outputFormat="empty",numberOfIntervals=17520,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements")
translateModel(IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements,tolerance=1e-06,outputFormat="empty",numberOfIntervals=17520,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001191/0.001191, allocations: 113 kB / 17.09 MB, free: 5.949 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001168/0.001168, allocations: 198.8 kB / 18.03 MB, free: 5.031 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.217/1.217, allocations: 222.9 MB / 241.7 MB, free: 15.18 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.6601/0.6601, allocations: 115.3 MB / 407.2 MB, free: 6.125 MB / 318.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001139/0.001139, allocations: 68.94 kB / 0.5583 GB, free: 32.26 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1088/0.11, allocations: 76.19 MB / 0.6327 GB, free: 4.434 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements): time 0.4173/0.5273, allocations: 162.6 MB / 0.7915 GB, free: 13.73 MB / 0.5919 GB
Notification: Performance of NFInst.instExpressions: time 0.02497/0.5523, allocations: 27.13 MB / 0.818 GB, free: 9.137 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002343/0.5547, allocations: 78 kB / 0.8181 GB, free: 9.109 MB / 0.5919 GB
Notification: Performance of NFTyping.typeComponents: time 0.001774/0.5565, allocations: 1.071 MB / 0.8191 GB, free: 8.363 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.003695/0.5602, allocations: 1.855 MB / 0.8209 GB, free: 7.219 MB / 0.5919 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003516/0.5638, allocations: 1.788 MB / 0.8227 GB, free: 5.949 MB / 0.5919 GB
Notification: Performance of NFFlatten.flatten: time 0.004571/0.5684, allocations: 5.554 MB / 0.8281 GB, free: 2.66 MB / 0.5919 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004083/0.5725, allocations: 4.338 MB / 0.8323 GB, free: 68 kB / 0.5919 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002558/0.575, allocations: 2.213 MB / 0.8345 GB, free: 14.86 MB / 0.6075 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002614/0.5776, allocations: 2.623 MB / 0.8371 GB, free: 13.29 MB / 0.6075 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005447/0.5782, allocations: 482.2 kB / 0.8375 GB, free: 13.29 MB / 0.6075 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001808/0.58, allocations: 1.09 MB / 0.8386 GB, free: 13.02 MB / 0.6075 GB
Notification: Performance of NFScalarize.scalarize: time 0.0008584/0.5809, allocations: 1.236 MB / 0.8398 GB, free: 12.09 MB / 0.6075 GB
Notification: Performance of NFVerifyModel.verify: time 0.001764/0.5827, allocations: 2.233 MB / 0.842 GB, free: 10.5 MB / 0.6075 GB
Notification: Performance of NFConvertDAE.convert: time 0.005299/0.588, allocations: 6.268 MB / 0.8481 GB, free: 5.078 MB / 0.6075 GB
Notification: Performance of FrontEnd - DAE generated: time 3.717e-06/0.588, allocations: 0 / 0.8481 GB, free: 5.078 MB / 0.6075 GB
Notification: Performance of FrontEnd: time 1.513e-06/0.588, allocations: 4 kB / 0.8481 GB, free: 5.074 MB / 0.6075 GB
Notification: Performance of Transformations before backend: time 5.399e-05/0.5881, allocations: 0 / 0.8481 GB, free: 5.074 MB / 0.6075 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 852
 * Number of variables: 852
Notification: Performance of Generate backend data structure: time 0.008328/0.5964, allocations: 4.813 MB / 0.8528 GB, free: 192 kB / 0.6075 GB
Notification: Performance of prepare preOptimizeDAE: time 3.708e-05/0.5964, allocations: 12.03 kB / 0.8528 GB, free: 180 kB / 0.6075 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01272/0.6092, allocations: 2.796 MB / 0.8555 GB, free: 13.37 MB / 0.6231 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003464/0.6126, allocations: 2.396 MB / 0.8579 GB, free: 10.95 MB / 0.6231 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001681/0.6128, allocations: 246.7 kB / 0.8581 GB, free: 10.71 MB / 0.6231 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004826/0.6133, allocations: 332 kB / 0.8584 GB, free: 10.38 MB / 0.6231 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01004/0.6233, allocations: 5.338 MB / 0.8636 GB, free: 4.969 MB / 0.6231 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.489e-05/0.6234, allocations: 7.922 kB / 0.8637 GB, free: 4.961 MB / 0.6231 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003644/0.6238, allocations: 136 kB / 0.8638 GB, free: 4.828 MB / 0.6231 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.12e-05/0.6238, allocations: 80 kB / 0.8639 GB, free: 4.75 MB / 0.6231 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01372/0.6376, allocations: 6.476 MB / 0.8702 GB, free: 14.26 MB / 0.6387 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.02202/0.6596, allocations: 15.67 MB / 0.8855 GB, free: 14.02 MB / 0.6544 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01006/0.6697, allocations: 4.864 MB / 0.8902 GB, free: 9.145 MB / 0.6544 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004913/0.6746, allocations: 2.579 MB / 0.8928 GB, free: 6.559 MB / 0.6544 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0008247/0.6754, allocations: 0.6759 MB / 0.8934 GB, free: 5.77 MB / 0.6544 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.005275/0.6807, allocations: 2.706 MB / 0.8961 GB, free: 3.023 MB / 0.6544 GB
Notification: Performance of pre-optimization done (n=291): time 4.669e-06/0.6807, allocations: 4 kB / 0.8961 GB, free: 3.02 MB / 0.6544 GB
Notification: Performance of matching and sorting (n=291): time 0.01778/0.6985, allocations: 8.008 MB / 0.9039 GB, free: 10.9 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.738e-05/0.6986, allocations: 214.2 kB / 0.9041 GB, free: 10.64 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002806/0.7014, allocations: 2.52 MB / 0.9066 GB, free: 8.102 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002491/0.7017, allocations: 85.69 kB / 0.9066 GB, free: 8.012 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001008/0.7027, allocations: 1.391 MB / 0.908 GB, free: 6.605 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0007445/0.7035, allocations: 0.9546 MB / 0.9089 GB, free: 5.66 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0008744/0.7043, allocations: 0.5169 MB / 0.9094 GB, free: 5.137 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 8.748e-05/0.7044, allocations: 305.1 kB / 0.9097 GB, free: 4.836 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004439/0.7089, allocations: 2.105 MB / 0.9118 GB, free: 2.727 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004699/0.7136, allocations: 2.42 MB / 0.9141 GB, free: 240 kB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.009107/0.7227, allocations: 4.448 MB / 0.9185 GB, free: 11.7 MB / 0.6856 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.751e-06/0.7227, allocations: 0 / 0.9185 GB, free: 11.7 MB / 0.6856 GB
Notification: Performance of matching and sorting (n=336) (initialization): time 0.0108/0.7335, allocations: 5.257 MB / 0.9236 GB, free: 6.398 MB / 0.6856 GB
Notification: Performance of prepare postOptimizeDAE: time 1.986e-05/0.7336, allocations: 8 kB / 0.9236 GB, free: 6.391 MB / 0.6856 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.226e-05/0.7336, allocations: 4.156 kB / 0.9236 GB, free: 6.387 MB / 0.6856 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007692/0.7344, allocations: 352.6 kB / 0.924 GB, free: 6.039 MB / 0.6856 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003823/0.7382, allocations: 0.8229 MB / 0.9248 GB, free: 5.215 MB / 0.6856 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004981/0.7432, allocations: 4.224 MB / 0.9289 GB, free: 0.8594 MB / 0.6856 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003353/0.7466, allocations: 0.5674 MB / 0.9294 GB, free: 296 kB / 0.6856 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002496/0.7468, allocations: 115.9 kB / 0.9296 GB, free: 180 kB / 0.6856 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 17
 * Number of states: 0 ()
 * Number of discrete variables: 34 ($PRE.intGai.nextTimeEvent,$whenCondition1,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,intGai.nextTimeEventScaled,$PRE.intGai.nextTimeEventScaled,intGai.nextTimeEvent,HDirTil[2].incAng.decAng.tNext,$PRE.HDirTil[2].incAng.decAng.tNext,HDirTil[1].incAng.decAng.tNext,$PRE.HDirTil[1].incAng.decAng.tNext,HDifTil[2].incAng.decAng.tNext,$PRE.HDifTil[2].incAng.decAng.tNext,HDifTil[1].incAng.decAng.tNext,$PRE.HDifTil[1].incAng.decAng.tNext,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (306):
 * Single equations (assignments): 305
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(3,28,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.001637/0.7485, allocations: 0.9817 MB / 0.9305 GB, free: 15.18 MB / 0.7012 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000519/0.749, allocations: 292.4 kB / 0.9308 GB, free: 14.89 MB / 0.7012 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0124/0.7614, allocations: 5.899 MB / 0.9366 GB, free: 8.938 MB / 0.7012 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.729e-05/0.7614, allocations: 15.94 kB / 0.9366 GB, free: 8.922 MB / 0.7012 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.68e-06/0.7614, allocations: 0 / 0.9366 GB, free: 8.922 MB / 0.7012 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001264/0.7627, allocations: 0.8714 MB / 0.9374 GB, free: 8.027 MB / 0.7012 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004591/0.7632, allocations: 75.83 kB / 0.9375 GB, free: 7.953 MB / 0.7012 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002938/0.7661, allocations: 417.1 kB / 0.9379 GB, free: 7.547 MB / 0.7012 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004018/0.7665, allocations: 226.1 kB / 0.9381 GB, free: 7.324 MB / 0.7012 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01308/0.7796, allocations: 5.691 MB / 0.9437 GB, free: 1.637 MB / 0.7012 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01528/0.7949, allocations: 8.297 MB / 0.9518 GB, free: 9.266 MB / 0.7169 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004465/0.7994, allocations: 2.447 MB / 0.9542 GB, free: 6.805 MB / 0.7169 GB
Notification: Performance of sorting global known variables: time 0.002255/0.8017, allocations: 1.838 MB / 0.956 GB, free: 4.957 MB / 0.7169 GB
Notification: Performance of Backend: time 3.01e-07/0.8017, allocations: 0 / 0.956 GB, free: 4.957 MB / 0.7169 GB
Notification: Performance of simCode: created initialization part: time 0.009303/0.811, allocations: 4.271 MB / 0.9601 GB, free: 1.121 MB / 0.7169 GB
Notification: Performance of SimCode: time 0.009898/0.8209, allocations: 7.168 MB / 0.9671 GB, free: 9.941 MB / 0.7325 GB
Notification: Performance of Templates: time 0.0837/0.9046, allocations: 62.03 MB / 1.028 GB, free: 12.24 MB / 0.795 GB
make -j1 -f IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements.makefile
(rm -f IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements.pipe ; mkfifo IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements.pipe >> ../files/IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements.sim & ./IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomTwoElements.pipe 2>&1)