Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle.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.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle")
translateModel(IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001161/0.001161, allocations: 107 kB / 16.4 MB, free: 6.492 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.00114/0.001141, allocations: 193.2 kB / 17.34 MB, free: 5.766 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.347/1.347, allocations: 222.9 MB / 241 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.7257/0.7257, allocations: 115.3 MB / 406.5 MB, free: 6.141 MB / 318.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001208/0.001208, allocations: 62.8 kB / 0.5576 GB, free: 32.36 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1468/0.148, allocations: 76.19 MB / 0.632 GB, free: 4.461 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle): time 0.008911/0.157, allocations: 6.894 MB / 0.6388 GB, free: 13.53 MB / 494.1 MB
Notification: Performance of NFInst.instExpressions: time 0.5393/0.6963, allocations: 151.3 MB / 0.7865 GB, free: 14.23 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00184/0.6982, allocations: 26.31 kB / 0.7865 GB, free: 14.22 MB / 0.5919 GB
Notification: Performance of NFTyping.typeComponents: time 0.0008126/0.6991, allocations: 265.9 kB / 0.7868 GB, free: 14.07 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.00243/0.7015, allocations: 0.7941 MB / 0.7876 GB, free: 13.81 MB / 0.5919 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002144/0.7037, allocations: 0.9932 MB / 0.7885 GB, free: 13.74 MB / 0.5919 GB
Notification: Performance of NFFlatten.flatten: time 0.002373/0.7061, allocations: 2.141 MB / 0.7906 GB, free: 13.37 MB / 0.5919 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001416/0.7075, allocations: 1.023 MB / 0.7916 GB, free: 13.1 MB / 0.5919 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001547/0.7091, allocations: 0.8475 MB / 0.7924 GB, free: 13.05 MB / 0.5919 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00119/0.7103, allocations: 0.902 MB / 0.7933 GB, free: 12.87 MB / 0.5919 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002897/0.7106, allocations: 210.6 kB / 0.7935 GB, free: 12.86 MB / 0.5919 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001116/0.7117, allocations: 0.5668 MB / 0.7941 GB, free: 12.84 MB / 0.5919 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003686/0.7121, allocations: 486.7 kB / 0.7945 GB, free: 12.77 MB / 0.5919 GB
Notification: Performance of NFVerifyModel.verify: time 0.0007952/0.7129, allocations: 0.9525 MB / 0.7955 GB, free: 12.5 MB / 0.5919 GB
Notification: Performance of NFConvertDAE.convert: time 0.002507/0.7154, allocations: 2.567 MB / 0.798 GB, free: 12.11 MB / 0.5919 GB
Notification: Performance of FrontEnd - DAE generated: time 5.861e-06/0.7154, allocations: 0 / 0.798 GB, free: 12.11 MB / 0.5919 GB
Notification: Performance of FrontEnd: time 2.274e-06/0.7154, allocations: 0 / 0.798 GB, free: 12.11 MB / 0.5919 GB
Notification: Performance of Transformations before backend: time 2.874e-05/0.7154, allocations: 0 / 0.798 GB, free: 12.11 MB / 0.5919 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 392
 * Number of variables: 392
Notification: Performance of Generate backend data structure: time 0.004133/0.7196, allocations: 2.064 MB / 0.8 GB, free: 11.07 MB / 0.5919 GB
Notification: Performance of prepare preOptimizeDAE: time 4.393e-05/0.7196, allocations: 10.25 kB / 0.8 GB, free: 11.07 MB / 0.5919 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00117/0.7208, allocations: 257 kB / 0.8002 GB, free: 10.97 MB / 0.5919 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001681/0.7225, allocations: 0.9947 MB / 0.8012 GB, free: 10.56 MB / 0.5919 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.845e-05/0.7226, allocations: 116.6 kB / 0.8013 GB, free: 10.55 MB / 0.5919 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001793/0.7228, allocations: 148.7 kB / 0.8015 GB, free: 10.55 MB / 0.5919 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002621/0.7254, allocations: 1.58 MB / 0.803 GB, free: 10.06 MB / 0.5919 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.894e-05/0.7255, allocations: 0.9688 kB / 0.803 GB, free: 10.06 MB / 0.5919 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001228/0.7256, allocations: 67.98 kB / 0.8031 GB, free: 10.06 MB / 0.5919 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.548e-05/0.7256, allocations: 37.34 kB / 0.8031 GB, free: 10.06 MB / 0.5919 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002499/0.7281, allocations: 1.64 MB / 0.8047 GB, free: 9.688 MB / 0.5919 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.006801/0.735, allocations: 4.532 MB / 0.8091 GB, free: 7.059 MB / 0.5919 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002052/0.737, allocations: 1.193 MB / 0.8103 GB, free: 6.457 MB / 0.5919 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007833/0.7378, allocations: 476.8 kB / 0.8108 GB, free: 6.219 MB / 0.5919 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001019/0.7379, allocations: 45.38 kB / 0.8108 GB, free: 6.203 MB / 0.5919 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001385/0.7393, allocations: 0.7834 MB / 0.8116 GB, free: 5.707 MB / 0.5919 GB
Notification: Performance of pre-optimization done (n=128): time 3.536e-06/0.7393, allocations: 0 / 0.8116 GB, free: 5.707 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=128): time 0.004329/0.7437, allocations: 1.845 MB / 0.8134 GB, free: 4.738 MB / 0.5919 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001187/0.7438, allocations: 197.6 kB / 0.8136 GB, free: 4.516 MB / 0.5919 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001221/0.745, allocations: 0.87 MB / 0.8144 GB, free: 4.008 MB / 0.5919 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001093/0.7452, allocations: 55.98 kB / 0.8145 GB, free: 3.957 MB / 0.5919 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005121/0.7457, allocations: 0.5992 MB / 0.8151 GB, free: 3.422 MB / 0.5919 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003454/0.746, allocations: 413.7 kB / 0.8154 GB, free: 3.074 MB / 0.5919 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003936/0.7464, allocations: 256.2 kB / 0.8157 GB, free: 2.918 MB / 0.5919 GB
Notification: Performance of setup shared object (initialization): time 0.0001313/0.7466, allocations: 352.3 kB / 0.816 GB, free: 2.578 MB / 0.5919 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008128/0.7474, allocations: 451.6 kB / 0.8165 GB, free: 2.355 MB / 0.5919 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0009697/0.7484, allocations: 0.5602 MB / 0.817 GB, free: 2.035 MB / 0.5919 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001759/0.7501, allocations: 0.9926 MB / 0.818 GB, free: 1.504 MB / 0.5919 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.001e-06/0.7502, allocations: 2.781 kB / 0.818 GB, free: 1.504 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=159) (initialization): time 0.003058/0.7532, allocations: 1.345 MB / 0.8193 GB, free: 0.8203 MB / 0.5919 GB
Notification: Performance of prepare postOptimizeDAE: time 2.472e-05/0.7533, allocations: 8.75 kB / 0.8193 GB, free: 0.8164 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.276e-06/0.7533, allocations: 0 / 0.8193 GB, free: 0.8164 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006477/0.7539, allocations: 88.52 kB / 0.8194 GB, free: 0.7734 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001232/0.7552, allocations: 260.6 kB / 0.8196 GB, free: 0.707 MB / 0.5919 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002285/0.7575, allocations: 1.656 MB / 0.8212 GB, free: 15.09 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001454/0.759, allocations: 148.8 kB / 0.8214 GB, free: 15 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000137/0.7591, allocations: 59.27 kB / 0.8214 GB, free: 14.97 MB / 0.6075 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 4
 * Number of states: 0 ()
 * Number of discrete variables: 32 (weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,incAngEas.decAng.tNext,$PRE.incAngEas.decAng.tNext,incAngSou.decAng.tNext,$PRE.incAngSou.decAng.tNext,incAngWes.decAng.tNext,$PRE.incAngWes.decAng.tNext,incAngNor.decAng.tNext,$PRE.incAngNor.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,incAngHor.decAng.tNext,$PRE.incAngHor.decAng.tNext,$whenCondition1,$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 (157):
 * Single equations (assignments): 156
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.0007715/0.7599, allocations: 352.6 kB / 0.8218 GB, free: 14.71 MB / 0.6075 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000319/0.7602, allocations: 120.3 kB / 0.8219 GB, free: 14.65 MB / 0.6075 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003729/0.7639, allocations: 1.706 MB / 0.8236 GB, free: 13.7 MB / 0.6075 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.572e-05/0.764, allocations: 15.06 kB / 0.8236 GB, free: 13.7 MB / 0.6075 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.208e-06/0.764, allocations: 0 / 0.8236 GB, free: 13.7 MB / 0.6075 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.279e-05/0.764, allocations: 7.984 kB / 0.8236 GB, free: 13.69 MB / 0.6075 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00201/0.766, allocations: 1.419 MB / 0.825 GB, free: 12.68 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.791e-06/0.7661, allocations: 0 / 0.825 GB, free: 12.68 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0009346/0.767, allocations: 213.8 kB / 0.8252 GB, free: 12.63 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0004687/0.7675, allocations: 81.19 kB / 0.8253 GB, free: 12.59 MB / 0.6075 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 9.379e-05/0.7676, allocations: 37.56 kB / 0.8253 GB, free: 12.56 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001972/0.7696, allocations: 1.663 MB / 0.8269 GB, free: 10.95 MB / 0.6075 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.076e-06/0.7696, allocations: 9.812 kB / 0.8269 GB, free: 10.94 MB / 0.6075 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003026/0.7726, allocations: 1.408 MB / 0.8283 GB, free: 10.21 MB / 0.6075 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007937/0.7734, allocations: 375.1 kB / 0.8287 GB, free: 9.895 MB / 0.6075 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003117/0.7737, allocations: 41.52 kB / 0.8287 GB, free: 9.863 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001083/0.7748, allocations: 84.25 kB / 0.8288 GB, free: 9.82 MB / 0.6075 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002397/0.7751, allocations: 114.2 kB / 0.8289 GB, free: 9.758 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001254/0.7752, allocations: 47.84 kB / 0.8289 GB, free: 9.742 MB / 0.6075 GB
Notification: Performance of sorting global known variables: time 0.001076/0.7763, allocations: 0.644 MB / 0.8296 GB, free: 9.371 MB / 0.6075 GB
Notification: Performance of sort global known variables: time 3.41e-07/0.7763, allocations: 2.406 kB / 0.8296 GB, free: 9.371 MB / 0.6075 GB
Notification: Performance of remove unused functions: time 0.001511/0.7778, allocations: 495.1 kB / 0.83 GB, free: 9.23 MB / 0.6075 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 0 ()
 * Number of discrete variables: 20 ($whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,incAngHor.decAng.tNext,weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,incAngNor.decAng.tNext,incAngWes.decAng.tNext,incAngSou.decAng.tNext,incAngEas.decAng.tNext)
 * Number of discrete states: 10 (incAngHor.decAng.tNext,weaDat.locTim.tNext,weaDat.conTimMin.tNext,weaDat.conTim.tNext,weaDat.eqnTim.tNext,weaDat.decAng.tNext,incAngNor.decAng.tNext,incAngWes.decAng.tNext,incAngSou.decAng.tNext,incAngEas.decAng.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (144):
 * Single equations (assignments): 133
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 10
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.001627/0.7795, allocations: 0.6245 MB / 0.8306 GB, free: 8.895 MB / 0.6075 GB
Notification: Performance of simCode: created initialization part: time 0.002899/0.7824, allocations: 1.271 MB / 0.8319 GB, free: 7.613 MB / 0.6075 GB
Notification: Performance of simCode: created event and clocks part: time 6.322e-06/0.7824, allocations: 0 / 0.8319 GB, free: 7.613 MB / 0.6075 GB
Notification: Performance of simCode: created simulation system equations: time 0.001436/0.7838, allocations: 0.7462 MB / 0.8326 GB, free: 6.855 MB / 0.6075 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001861/0.7857, allocations: 347 kB / 0.8329 GB, free: 6.539 MB / 0.6075 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005089/0.7908, allocations: 2.545 MB / 0.8354 GB, free: 3.969 MB / 0.6075 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001166/0.792, allocations: 1.24 MB / 0.8366 GB, free: 2.691 MB / 0.6075 GB
Notification: Performance of simCode: alias equations: time 0.001408/0.7934, allocations: 334.1 kB / 0.837 GB, free: 2.363 MB / 0.6075 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005241/0.794, allocations: 155.3 kB / 0.8371 GB, free: 2.211 MB / 0.6075 GB
Notification: Performance of SimCode: time 5.01e-07/0.794, allocations: 0 / 0.8371 GB, free: 2.211 MB / 0.6075 GB
Notification: Performance of Templates: time 0.0416/0.8356, allocations: 22.43 MB / 0.859 GB, free: 11.98 MB / 0.6387 GB
make -j1 -f IBPSA_latest_IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle.makefile
(rm -f IBPSA_latest_IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle.pipe ; mkfifo IBPSA_latest_IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle.pipe >> ../files/IBPSA_latest_IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle.sim & ./IBPSA_latest_IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.BoundaryConditions.SolarGeometry.Examples.IncidenceAngle.pipe 2>&1)