Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements.conf.json
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/IBPSA 4.0.0-master/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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/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 IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/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)
Running command: translateModel(IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements,tolerance=1e-06,outputFormat="empty",numberOfIntervals=17520,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements")
translateModel(IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements,tolerance=1e-06,outputFormat="empty",numberOfIntervals=17520,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001161/0.001161, allocations: 186.6 kB / 16.63 MB, free: 5.117 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.4668/0.4668, allocations: 87.5 MB / 104.9 MB, free: 13.01 MB / 90.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.421/1.421, allocations: 222.9 MB / 349.1 MB, free: 2.742 MB / 282.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001002/0.001002, allocations: 102.2 kB / 420 MB, free: 8.492 MB / 314.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.001138/0.001138, allocations: 55.92 kB / 0.4891 GB, free: 7.707 MB / 394.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3035/0.3047, allocations: 70.06 MB / 0.5575 GB, free: 44.8 MB / 410.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements): time 0.4786/0.7833, allocations: 160.7 MB / 0.7144 GB, free: 1.504 MB / 0.5105 GB
Notification: Performance of NFInst.instExpressions: time 0.03265/0.8161, allocations: 27.28 MB / 0.741 GB, free: 1.117 MB / 0.5105 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003685/0.8198, allocations: 78.47 kB / 0.7411 GB, free: 1.117 MB / 0.5105 GB
Notification: Performance of NFTyping.typeComponents: time 0.002921/0.8228, allocations: 0.9965 MB / 0.7421 GB, free: 1.098 MB / 0.5105 GB
Notification: Performance of NFTyping.typeBindings: time 0.008884/0.8317, allocations: 1.717 MB / 0.7437 GB, free: 1.023 MB / 0.5105 GB
Notification: Performance of NFTyping.typeClassSections: time 0.008082/0.8398, allocations: 1.759 MB / 0.7455 GB, free: 0.9648 MB / 0.5105 GB
Notification: Performance of NFFlatten.flatten: time 0.01013/0.8499, allocations: 6.214 MB / 0.7515 GB, free: 0.9492 MB / 0.5105 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00689/0.8569, allocations: 4.34 MB / 0.7558 GB, free: 16.28 MB / 0.5261 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004117/0.861, allocations: 1.933 MB / 0.7577 GB, free: 16.2 MB / 0.5261 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004334/0.8654, allocations: 2.644 MB / 0.7602 GB, free: 15.75 MB / 0.5261 GB
Notification: Performance of NFPackage.collectConstants: time 0.0008759/0.8663, allocations: 289.7 kB / 0.7605 GB, free: 15.75 MB / 0.5261 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00295/0.8693, allocations: 0.8845 MB / 0.7614 GB, free: 15.72 MB / 0.5261 GB
Notification: Performance of NFScalarize.scalarize: time 0.001214/0.8705, allocations: 1.105 MB / 0.7625 GB, free: 15.55 MB / 0.5261 GB
Notification: Performance of NFVerifyModel.verify: time 0.003549/0.874, allocations: 2.13 MB / 0.7645 GB, free: 14.87 MB / 0.5261 GB
Notification: Performance of NFConvertDAE.convert: time 0.008421/0.8825, allocations: 6.435 MB / 0.7708 GB, free: 12.62 MB / 0.5261 GB
Notification: Performance of FrontEnd - DAE generated: time 9.327e-06/0.8825, allocations: 0 / 0.7708 GB, free: 12.62 MB / 0.5261 GB
Notification: Performance of FrontEnd: time 2.275e-06/0.8825, allocations: 0 / 0.7708 GB, free: 12.62 MB / 0.5261 GB
Notification: Performance of Transformations before backend: time 0.0002696/0.8828, allocations: 2.781 kB / 0.7708 GB, free: 12.62 MB / 0.5261 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 962
 * Number of variables: 962
Notification: Performance of Generate backend data structure: time 0.01589/0.8987, allocations: 5.093 MB / 0.7758 GB, free: 9.203 MB / 0.5261 GB
Notification: Performance of prepare preOptimizeDAE: time 4.704e-05/0.8988, allocations: 10.75 kB / 0.7758 GB, free: 9.203 MB / 0.5261 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01405/0.9129, allocations: 2.832 MB / 0.7786 GB, free: 7.848 MB / 0.5261 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006965/0.9199, allocations: 2.517 MB / 0.781 GB, free: 6.215 MB / 0.5261 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002695/0.9202, allocations: 279.6 kB / 0.7813 GB, free: 6.09 MB / 0.5261 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001461/0.9216, allocations: 368.1 kB / 0.7817 GB, free: 5.969 MB / 0.5261 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01482/0.9365, allocations: 5.731 MB / 0.7872 GB, free: 336 kB / 0.5261 GB
Notification: Performance of preOpt findStateOrder (simulation): time 9.721e-05/0.9366, allocations: 4 kB / 0.7873 GB, free: 332 kB / 0.5261 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005301/0.9372, allocations: 156 kB / 0.7874 GB, free: 176 kB / 0.5261 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.866e-05/0.9372, allocations: 92 kB / 0.7875 GB, free: 84 kB / 0.5261 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01974/0.957, allocations: 6.86 MB / 0.7942 GB, free: 9.223 MB / 0.5417 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.04067/0.9977, allocations: 17.37 MB / 0.8112 GB, free: 7.449 MB / 0.5573 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01153/1.009, allocations: 4.484 MB / 0.8155 GB, free: 2.977 MB / 0.5573 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.007101/1.016, allocations: 2.951 MB / 0.8184 GB, free: 20 kB / 0.5573 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.00119/1.018, allocations: 0.6769 MB / 0.8191 GB, free: 15.23 MB / 0.573 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007191/1.025, allocations: 2.724 MB / 0.8217 GB, free: 12.47 MB / 0.573 GB
Notification: Performance of pre-optimization done (n=315): time 6.652e-06/1.025, allocations: 0 / 0.8217 GB, free: 12.47 MB / 0.573 GB
Notification: Performance of matching and sorting (n=315): time 0.03044/1.055, allocations: 9.697 MB / 0.8312 GB, free: 2.676 MB / 0.573 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000139/1.056, allocations: 210.4 kB / 0.8314 GB, free: 2.426 MB / 0.573 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005539/1.061, allocations: 2.654 MB / 0.834 GB, free: 15.76 MB / 0.5886 GB
Notification: Performance of collectPreVariables (initialization): time 0.00108/1.062, allocations: 85.7 kB / 0.8341 GB, free: 15.67 MB / 0.5886 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002333/1.065, allocations: 1.532 MB / 0.8356 GB, free: 14.12 MB / 0.5886 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003068/1.068, allocations: 1.052 MB / 0.8366 GB, free: 13.08 MB / 0.5886 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003462/1.071, allocations: 0.5369 MB / 0.8371 GB, free: 12.54 MB / 0.5886 GB
Notification: Performance of setup shared object (initialization): time 9.777e-05/1.071, allocations: 301.1 kB / 0.8374 GB, free: 12.24 MB / 0.5886 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.006141/1.077, allocations: 2.183 MB / 0.8395 GB, free: 10.05 MB / 0.5886 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006541/1.084, allocations: 2.533 MB / 0.842 GB, free: 7.449 MB / 0.5886 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01261/1.097, allocations: 4.708 MB / 0.8466 GB, free: 2.676 MB / 0.5886 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.326e-05/1.097, allocations: 4 kB / 0.8466 GB, free: 2.672 MB / 0.5886 GB
Notification: Performance of matching and sorting (n=355) (initialization): time 0.01716/1.114, allocations: 5.808 MB / 0.8523 GB, free: 12.87 MB / 0.6042 GB
Notification: Performance of prepare postOptimizeDAE: time 3.002e-05/1.114, allocations: 4 kB / 0.8523 GB, free: 12.87 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.758e-05/1.114, allocations: 4 kB / 0.8523 GB, free: 12.86 MB / 0.6042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001949/1.116, allocations: 0.8396 MB / 0.8531 GB, free: 12.02 MB / 0.6042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004795/1.121, allocations: 0.8051 MB / 0.8539 GB, free: 11.24 MB / 0.6042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01252/1.133, allocations: 7.014 MB / 0.8608 GB, free: 4.121 MB / 0.6042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005448/1.139, allocations: 0.5906 MB / 0.8613 GB, free: 3.527 MB / 0.6042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001287/1.14, allocations: 119.9 kB / 0.8614 GB, free: 3.41 MB / 0.6042 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 17
 * Number of states: 0 ()
 * Number of discrete variables: 13 ($PRE.intGai.nextTimeEvent,$whenCondition1,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,intGai.nextTimeEventScaled,$PRE.intGai.nextTimeEventScaled,intGai.nextTimeEvent,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,$whenCondition2,$whenCondition3)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (291):
 * Single equations (assignments): 290
 * 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
   {(5,60,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.004199/1.144, allocations: 1.03 MB / 0.8625 GB, free: 2.398 MB / 0.6042 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001512/1.146, allocations: 308.1 kB / 0.8627 GB, free: 2.094 MB / 0.6042 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01743/1.163, allocations: 6.388 MB / 0.869 GB, free: 11.68 MB / 0.6198 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.596e-05/1.163, allocations: 32 kB / 0.869 GB, free: 11.64 MB / 0.6198 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.202e-05/1.163, allocations: 12 kB / 0.869 GB, free: 11.63 MB / 0.6198 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.684e-05/1.164, allocations: 15.94 kB / 0.869 GB, free: 11.62 MB / 0.6198 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02943/1.193, allocations: 10.71 MB / 0.8795 GB, free: 0.8867 MB / 0.6198 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.708e-05/1.193, allocations: 0 / 0.8795 GB, free: 0.8867 MB / 0.6198 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.004582/1.198, allocations: 0.7664 MB / 0.8802 GB, free: 148 kB / 0.6198 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002348/1.2, allocations: 0.7401 MB / 0.881 GB, free: 15.4 MB / 0.6355 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0008477/1.201, allocations: 83.94 kB / 0.8811 GB, free: 15.32 MB / 0.6355 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01149/1.212, allocations: 9.811 MB / 0.8906 GB, free: 5.125 MB / 0.6355 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.144e-06/1.212, allocations: 0 / 0.8906 GB, free: 5.125 MB / 0.6355 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.8111/2.024, allocations: 136.2 MB / 1.024 GB, free: 271.8 MB / 0.698 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00256/2.026, allocations: 0.8985 MB / 1.025 GB, free: 270.9 MB / 0.698 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005154/2.027, allocations: 67.84 kB / 1.025 GB, free: 270.8 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003056/2.03, allocations: 427.3 kB / 1.025 GB, free: 270.4 MB / 0.698 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004768/2.03, allocations: 210.3 kB / 1.025 GB, free: 270.2 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002463/2.031, allocations: 107.9 kB / 1.025 GB, free: 270.1 MB / 0.698 GB
Notification: Performance of sorting global known variables: time 0.002068/2.033, allocations: 1.924 MB / 1.027 GB, free: 268.2 MB / 0.698 GB
Notification: Performance of sort global known variables: time 2.31e-07/2.033, allocations: 0 / 1.027 GB, free: 268.2 MB / 0.698 GB
Notification: Performance of remove unused functions: time 0.005159/2.038, allocations: 1.879 MB / 1.029 GB, free: 266.3 MB / 0.698 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 6 (thermalZoneFourElements.volAir.dynBal.U,thermalZoneFourElements.volAir.dynBal.m,thermalZoneFourElements.extWallRC.thermCapExt[1].T,thermalZoneFourElements.intWallRC.thermCapInt[1].T,thermalZoneFourElements.floorRC.thermCapExt[1].T,thermalZoneFourElements.roofRC.thermCapExt[1].T)
 * Number of discrete variables: 7 ($whenCondition3,$whenCondition2,$whenCondition1,weaDat.conTimMin.tNext,weaDat.conTim.tNext,intGai.nextTimeEvent,intGai.nextTimeEventScaled)
 * Number of discrete states: 4 (intGai.nextTimeEvent,intGai.nextTimeEventScaled,weaDat.conTimMin.tNext,weaDat.conTim.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (270):
 * Single equations (assignments): 262
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 4
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 3 systems
   {(5,49,100.0%), (1,3,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.002355/2.04, allocations: 1.089 MB / 1.03 GB, free: 265.7 MB / 0.698 GB
Notification: Performance of simCode: created initialization part: time 0.0104/2.051, allocations: 5.504 MB / 1.035 GB, free: 260.2 MB / 0.698 GB
Notification: Performance of simCode: created event and clocks part: time 3.967e-06/2.051, allocations: 0 / 1.035 GB, free: 260.2 MB / 0.698 GB
Notification: Performance of simCode: created simulation system equations: time 0.005714/2.056, allocations: 3.321 MB / 1.039 GB, free: 256.8 MB / 0.698 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003507/2.06, allocations: 0.7178 MB / 1.039 GB, free: 256.1 MB / 0.698 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01917/2.079, allocations: 13.54 MB / 1.053 GB, free: 242.5 MB / 0.698 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002449/2.081, allocations: 2.83 MB / 1.055 GB, free: 239.6 MB / 0.698 GB
Notification: Performance of simCode: alias equations: time 0.006648/2.088, allocations: 1.482 MB / 1.057 GB, free: 238.1 MB / 0.698 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.00254/2.091, allocations: 347.1 kB / 1.057 GB, free: 237.8 MB / 0.698 GB
Notification: Performance of SimCode: time 6.41e-07/2.091, allocations: 0 / 1.057 GB, free: 237.8 MB / 0.698 GB
Notification: Performance of Templates: time 0.1374/2.228, allocations: 106.2 MB / 1.161 GB, free: 131.8 MB / 0.698 GB
make -j1 -f IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements.makefile
(rm -f IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements.pipe ; mkfifo IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements.pipe >> ../files/IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements.sim & ./IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Examples.SimpleRoomFourElements.pipe 2>&1)