Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4.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.Validation.VDI6007.TestCase4,tolerance=1e-06,outputFormat="empty",numberOfIntervals=172800,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4")
translateModel(IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4,tolerance=1e-06,outputFormat="empty",numberOfIntervals=172800,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001509/0.001509, allocations: 182.7 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.4966/0.4966, allocations: 87.5 MB / 104.9 MB, free: 13.02 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.316/1.316, allocations: 222.9 MB / 349.1 MB, free: 2.734 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.0009798/0.0009798, allocations: 107 kB / 420 MB, free: 8.488 MB / 314.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.001115/0.001115, allocations: 51.92 kB / 0.4891 GB, free: 7.691 MB / 394.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3002/0.3014, allocations: 70.06 MB / 0.5575 GB, free: 44.74 MB / 410.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4): time 0.146/0.4475, allocations: 154.4 MB / 0.7083 GB, free: 2.176 MB / 0.5105 GB
Notification: Performance of NFInst.instExpressions: time 0.3349/0.7824, allocations: 21.59 MB / 0.7294 GB, free: 1.355 MB / 0.5105 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002992/0.7855, allocations: 49.72 kB / 0.7294 GB, free: 1.355 MB / 0.5105 GB
Notification: Performance of NFTyping.typeComponents: time 0.001527/0.7871, allocations: 1.128 MB / 0.7305 GB, free: 1.316 MB / 0.5105 GB
Notification: Performance of NFTyping.typeBindings: time 0.001351/0.7884, allocations: 0.8082 MB / 0.7313 GB, free: 1.285 MB / 0.5105 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001112/0.7896, allocations: 380.4 kB / 0.7317 GB, free: 1.277 MB / 0.5105 GB
Notification: Performance of NFFlatten.flatten: time 0.001726/0.7913, allocations: 1.36 MB / 0.733 GB, free: 1.277 MB / 0.5105 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008261/0.7921, allocations: 0.6293 MB / 0.7336 GB, free: 1.195 MB / 0.5105 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0006878/0.7928, allocations: 0.4903 MB / 0.7341 GB, free: 1.195 MB / 0.5105 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001131/0.794, allocations: 0.9055 MB / 0.735 GB, free: 1.191 MB / 0.5105 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001654/0.7942, allocations: 37.44 kB / 0.735 GB, free: 1.191 MB / 0.5105 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0003741/0.7945, allocations: 87.38 kB / 0.7351 GB, free: 1.188 MB / 0.5105 GB
Notification: Performance of NFScalarize.scalarize: time 0.0004654/0.795, allocations: 304.8 kB / 0.7354 GB, free: 1.188 MB / 0.5105 GB
Notification: Performance of NFVerifyModel.verify: time 0.0005598/0.7956, allocations: 465.2 kB / 0.7359 GB, free: 1.188 MB / 0.5105 GB
Notification: Performance of NFConvertDAE.convert: time 0.0009753/0.7966, allocations: 1.149 MB / 0.737 GB, free: 1.098 MB / 0.5105 GB
Notification: Performance of FrontEnd - DAE generated: time 4.909e-06/0.7966, allocations: 3.812 kB / 0.737 GB, free: 1.098 MB / 0.5105 GB
Notification: Performance of FrontEnd: time 1.172e-06/0.7966, allocations: 0 / 0.737 GB, free: 1.098 MB / 0.5105 GB
Notification: Performance of Transformations before backend: time 1.23e-05/0.7966, allocations: 0 / 0.737 GB, free: 1.098 MB / 0.5105 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 107
 * Number of variables: 107
Notification: Performance of Generate backend data structure: time 0.002498/0.7991, allocations: 1.482 MB / 0.7384 GB, free: 16.22 MB / 0.5261 GB
Notification: Performance of prepare preOptimizeDAE: time 4.027e-05/0.7992, allocations: 8.938 kB / 0.7384 GB, free: 16.22 MB / 0.5261 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0001727/0.7993, allocations: 135.2 kB / 0.7386 GB, free: 16.15 MB / 0.5261 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0007653/0.8001, allocations: 0.6572 MB / 0.7392 GB, free: 15.76 MB / 0.5261 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001194/0.8002, allocations: 70.5 kB / 0.7393 GB, free: 15.73 MB / 0.5261 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 7.309e-05/0.8003, allocations: 51.5 kB / 0.7393 GB, free: 15.72 MB / 0.5261 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0008469/0.8012, allocations: 0.5204 MB / 0.7398 GB, free: 15.66 MB / 0.5261 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.979e-05/0.8012, allocations: 3.375 kB / 0.7398 GB, free: 15.66 MB / 0.5261 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.151e-05/0.8012, allocations: 16.47 kB / 0.7398 GB, free: 15.66 MB / 0.5261 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.212e-05/0.8013, allocations: 10.88 kB / 0.7399 GB, free: 15.66 MB / 0.5261 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0007455/0.802, allocations: 414.5 kB / 0.7403 GB, free: 15.66 MB / 0.5261 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.003864/0.8059, allocations: 2.802 MB / 0.743 GB, free: 14.16 MB / 0.5261 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001057/0.807, allocations: 459.8 kB / 0.7434 GB, free: 14.12 MB / 0.5261 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005411/0.8075, allocations: 285.4 kB / 0.7437 GB, free: 14.11 MB / 0.5261 GB
Notification: Performance of preOpt evalFunc (simulation): time 4.387e-05/0.8076, allocations: 5.891 kB / 0.7437 GB, free: 14.11 MB / 0.5261 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.000554/0.8081, allocations: 298.9 kB / 0.744 GB, free: 14.05 MB / 0.5261 GB
Notification: Performance of pre-optimization done (n=45): time 3.477e-06/0.8082, allocations: 4 kB / 0.744 GB, free: 14.05 MB / 0.5261 GB
Notification: Performance of matching and sorting (n=45): time 0.002816/0.811, allocations: 1.242 MB / 0.7452 GB, free: 13.71 MB / 0.5261 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.908e-05/0.811, allocations: 60.31 kB / 0.7453 GB, free: 13.65 MB / 0.5261 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001556/0.8126, allocations: 1.755 MB / 0.747 GB, free: 13.5 MB / 0.5261 GB
Notification: Performance of collectPreVariables (initialization): time 4.404e-05/0.8127, allocations: 39.02 kB / 0.747 GB, free: 13.46 MB / 0.5261 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003307/0.813, allocations: 0.5155 MB / 0.7475 GB, free: 13.33 MB / 0.5261 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001151/0.8131, allocations: 144.5 kB / 0.7477 GB, free: 13.24 MB / 0.5261 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001391/0.8133, allocations: 98.61 kB / 0.7478 GB, free: 13.22 MB / 0.5261 GB
Notification: Performance of setup shared object (initialization): time 0.0001049/0.8134, allocations: 328.5 kB / 0.7481 GB, free: 12.91 MB / 0.5261 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004307/0.8138, allocations: 219.8 kB / 0.7483 GB, free: 12.91 MB / 0.5261 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005216/0.8143, allocations: 327.5 kB / 0.7486 GB, free: 12.8 MB / 0.5261 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0008081/0.8152, allocations: 0.5089 MB / 0.7491 GB, free: 12.69 MB / 0.5261 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.347e-06/0.8152, allocations: 3.938 kB / 0.7491 GB, free: 12.68 MB / 0.5261 GB
Notification: Performance of matching and sorting (n=67) (initialization): time 0.001483/0.8167, allocations: 0.854 MB / 0.7499 GB, free: 12.55 MB / 0.5261 GB
Notification: Performance of prepare postOptimizeDAE: time 2.062e-05/0.8167, allocations: 9.469 kB / 0.7499 GB, free: 12.55 MB / 0.5261 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.645e-06/0.8167, allocations: 0 / 0.7499 GB, free: 12.55 MB / 0.5261 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0004826/0.8172, allocations: 186 kB / 0.7501 GB, free: 12.54 MB / 0.5261 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003363/0.8175, allocations: 96.67 kB / 0.7502 GB, free: 12.54 MB / 0.5261 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003062/0.8206, allocations: 2.746 MB / 0.7529 GB, free: 11.15 MB / 0.5261 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005473/0.8212, allocations: 80.75 kB / 0.753 GB, free: 11.12 MB / 0.5261 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.854e-05/0.8212, allocations: 20 kB / 0.753 GB, free: 11.12 MB / 0.5261 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 13
 * Number of states: 0 ()
 * Number of discrete variables: 19 (assEqu.nFai,$PRE.assEqu.nFai,$whenCondition5,$PRE.intGai.nextTimeEvent,$whenCondition4,$PRE.reference.nextTimeEvent,$whenCondition3,$whenCondition1,mean.y_last,$PRE.mean.y_last,assEqu.satisfied,$PRE.assEqu.satisfied,reference.nextTimeEventScaled,$PRE.reference.nextTimeEventScaled,reference.nextTimeEvent,$whenCondition2,intGai.nextTimeEventScaled,$PRE.intGai.nextTimeEventScaled,intGai.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (50):
 * Single equations (assignments): 49
 * 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
   {(2,16,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0006523/0.8219, allocations: 387.5 kB / 0.7533 GB, free: 11.01 MB / 0.5261 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001252/0.822, allocations: 111.3 kB / 0.7535 GB, free: 10.95 MB / 0.5261 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0002342/0.8223, allocations: 138.1 kB / 0.7536 GB, free: 10.93 MB / 0.5261 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.963e-06/0.8223, allocations: 9.719 kB / 0.7536 GB, free: 10.93 MB / 0.5261 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.559e-05/0.8223, allocations: 0 / 0.7536 GB, free: 10.93 MB / 0.5261 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.911e-06/0.8223, allocations: 6.031 kB / 0.7536 GB, free: 10.93 MB / 0.5261 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002311/0.8246, allocations: 1.566 MB / 0.7551 GB, free: 10.57 MB / 0.5261 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.936e-06/0.8246, allocations: 4 kB / 0.7551 GB, free: 10.57 MB / 0.5261 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002116/0.8249, allocations: 48.83 kB / 0.7552 GB, free: 10.57 MB / 0.5261 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0004411/0.8253, allocations: 193.8 kB / 0.7554 GB, free: 10.55 MB / 0.5261 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.304e-05/0.8254, allocations: 11.86 kB / 0.7554 GB, free: 10.55 MB / 0.5261 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003844/0.8292, allocations: 4.124 MB / 0.7594 GB, free: 7.836 MB / 0.5261 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.262e-06/0.8292, allocations: 0 / 0.7594 GB, free: 7.836 MB / 0.5261 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01441/0.8436, allocations: 9.791 MB / 0.769 GB, free: 3.578 MB / 0.5261 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000307/0.844, allocations: 210.3 kB / 0.7692 GB, free: 3.422 MB / 0.5261 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 9.016e-05/0.8441, allocations: 18.67 kB / 0.7692 GB, free: 3.418 MB / 0.5261 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003405/0.8444, allocations: 39.52 kB / 0.7692 GB, free: 3.41 MB / 0.5261 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001833/0.8446, allocations: 61.17 kB / 0.7693 GB, free: 3.402 MB / 0.5261 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.269e-05/0.8447, allocations: 17.12 kB / 0.7693 GB, free: 3.402 MB / 0.5261 GB
Notification: Performance of sorting global known variables: time 0.00165/0.8463, allocations: 1.277 MB / 0.7705 GB, free: 3.293 MB / 0.5261 GB
Notification: Performance of sort global known variables: time 1.864e-06/0.8464, allocations: 0 / 0.7705 GB, free: 3.293 MB / 0.5261 GB
Notification: Performance of remove unused functions: time 0.001307/0.8477, allocations: 307.8 kB / 0.7708 GB, free: 3.273 MB / 0.5261 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 4 (thermalZoneTwoElements.extWallRC.thermCapExt[1].T,thermalZoneTwoElements.intWallRC.thermCapInt[1].T,assEqu.diff,mean.x)
 * Number of discrete variables: 12 ($whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,intGai.nextTimeEvent,intGai.nextTimeEventScaled,reference.nextTimeEvent,reference.nextTimeEventScaled,assEqu.satisfied,assEqu.nFai,mean.y_last)
 * Number of discrete states: 7 (intGai.nextTimeEvent,reference.nextTimeEvent,mean.x,assEqu.satisfied,assEqu.nFai,reference.nextTimeEventScaled,intGai.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (28):
 * Single equations (assignments): 20
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 6
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(2,13,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.00109/0.8488, allocations: 486.7 kB / 0.7713 GB, free: 3.07 MB / 0.5261 GB
Notification: Performance of simCode: created initialization part: time 0.001557/0.8503, allocations: 0.7053 MB / 0.772 GB, free: 2.934 MB / 0.5261 GB
Notification: Performance of simCode: created event and clocks part: time 3.196e-06/0.8504, allocations: 0 / 0.772 GB, free: 2.934 MB / 0.5261 GB
Notification: Performance of simCode: created simulation system equations: time 0.0008916/0.8513, allocations: 0.5509 MB / 0.7725 GB, free: 2.688 MB / 0.5261 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001072/0.8523, allocations: 187.4 kB / 0.7727 GB, free: 2.676 MB / 0.5261 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004586/0.8569, allocations: 3.362 MB / 0.776 GB, free: 1.113 MB / 0.5261 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000872/0.8578, allocations: 1.178 MB / 0.7771 GB, free: 400 kB / 0.5261 GB
Notification: Performance of simCode: alias equations: time 0.000403/0.8582, allocations: 92.05 kB / 0.7772 GB, free: 380 kB / 0.5261 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001269/0.8584, allocations: 40.91 kB / 0.7773 GB, free: 372 kB / 0.5261 GB
Notification: Performance of SimCode: time 7.82e-07/0.8584, allocations: 0 / 0.7773 GB, free: 372 kB / 0.5261 GB
Notification: Performance of Templates: time 0.02082/0.8792, allocations: 11.93 MB / 0.7889 GB, free: 6.176 MB / 0.5417 GB
make -j1 -f IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4.makefile
(rm -f IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4.pipe ; mkfifo IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4.pipe >> ../files/IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4.sim & ./IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.ThermalZones.ReducedOrder.Validation.VDI6007.TestCase4.pipe 2>&1)