Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerSysPro_PowerSysPro.Examples.LargerNetwork.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/PowerSysPro 2.3.1-master/package.mo", uses=false)
Using package PowerSysPro with version 2.3.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSysPro 2.3.1-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(PowerSysPro.Examples.LargerNetwork,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="PowerSysPro_PowerSysPro.Examples.LargerNetwork")
translateModel(PowerSysPro.Examples.LargerNetwork,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="PowerSysPro_PowerSysPro.Examples.LargerNetwork")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001285/0.001285, allocations: 110 kB / 17.13 MB, free: 6.035 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.001309/0.001309, allocations: 196.2 kB / 18.07 MB, free: 5.113 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.311/1.311, allocations: 222.9 MB / 241.8 MB, free: 15.06 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSysPro 2.3.1-master/package.mo): time 0.04649/0.04649, allocations: 8.099 MB / 300 MB, free: 6.613 MB / 238.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001205/0.001205, allocations: 63.91 kB / 415.2 MB, free: 21.64 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08388/0.08509, allocations: 51.51 MB / 466.7 MB, free: 2.078 MB / 334.1 MB
Notification: Performance of NFInst.instantiate(PowerSysPro.Examples.LargerNetwork): time 0.01327/0.0984, allocations: 14.71 MB / 481.5 MB, free: 3.312 MB / 350.1 MB
Notification: Performance of NFInst.instExpressions: time 0.008091/0.1065, allocations: 3.957 MB / 485.4 MB, free: 15.33 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00192/0.1085, allocations: 44 kB / 485.5 MB, free: 15.29 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001495/0.11, allocations: 0.6941 MB / 486.1 MB, free: 14.59 MB / 366.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.004388/0.1144, allocations: 1.626 MB / 487.8 MB, free: 12.96 MB / 366.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004649/0.1191, allocations: 2.152 MB / 489.9 MB, free: 10.82 MB / 366.1 MB
Notification: Performance of NFFlatten.flatten: time 0.004877/0.124, allocations: 3.634 MB / 493.6 MB, free: 7.172 MB / 366.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001497/0.1255, allocations: 1.185 MB / 494.7 MB, free: 5.934 MB / 366.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001788/0.1273, allocations: 1.51 MB / 496.3 MB, free: 4.418 MB / 366.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001922/0.1292, allocations: 1.895 MB / 498.2 MB, free: 2.516 MB / 366.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.000455/0.1297, allocations: 300 kB / 498.4 MB, free: 2.223 MB / 366.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00109/0.1308, allocations: 0.5544 MB / 499 MB, free: 1.668 MB / 366.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0005317/0.1313, allocations: 0.7549 MB / 499.8 MB, free: 0.9102 MB / 366.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.00143/0.1328, allocations: 1.675 MB / 0.4897 GB, free: 15.23 MB / 382.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.003517/0.1363, allocations: 3.644 MB / 0.4932 GB, free: 11.57 MB / 382.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.468e-06/0.1363, allocations: 0 / 0.4932 GB, free: 11.57 MB / 382.1 MB
Notification: Performance of FrontEnd: time 1.864e-06/0.1363, allocations: 0 / 0.4932 GB, free: 11.57 MB / 382.1 MB
Notification: Performance of Transformations before backend: time 4.504e-05/0.1364, allocations: 0 / 0.4932 GB, free: 11.57 MB / 382.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 598
 * Number of variables: 598
Notification: Performance of Generate backend data structure: time 0.03329/0.1697, allocations: 8.189 MB / 0.5012 GB, free: 3.301 MB / 382.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.591e-05/0.1697, allocations: 8.031 kB / 0.5012 GB, free: 3.293 MB / 382.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0007478/0.1705, allocations: 376.8 kB / 0.5016 GB, free: 2.922 MB / 382.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002411/0.1729, allocations: 1.543 MB / 0.5031 GB, free: 1.332 MB / 382.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004123/0.1733, allocations: 0.7464 MB / 0.5038 GB, free: 472 kB / 382.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004111/0.1738, allocations: 268.4 kB / 0.5041 GB, free: 204 kB / 382.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.2218/0.3956, allocations: 3.789 MB / 0.5078 GB, free: 40.32 MB / 382.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.424e-05/0.3957, allocations: 3.812 kB / 0.5078 GB, free: 40.32 MB / 382.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003137/0.396, allocations: 112.2 kB / 0.5079 GB, free: 40.23 MB / 382.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.343e-05/0.396, allocations: 55.91 kB / 0.508 GB, free: 40.23 MB / 382.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005871/0.4019, allocations: 3.589 MB / 0.5115 GB, free: 38.71 MB / 382.1 MB
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.01938/0.4213, allocations: 14.06 MB / 0.5252 GB, free: 29.45 MB / 382.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.00649/0.4278, allocations: 7.575 MB / 0.5326 GB, free: 24.18 MB / 382.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003234/0.4311, allocations: 2.833 MB / 0.5354 GB, free: 22.61 MB / 382.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003106/0.4314, allocations: 93.5 kB / 0.5354 GB, free: 22.59 MB / 382.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.00382/0.4353, allocations: 3.015 MB / 0.5384 GB, free: 20.8 MB / 382.1 MB
Notification: Performance of pre-optimization done (n=453): time 6.021e-06/0.4353, allocations: 0 / 0.5384 GB, free: 20.8 MB / 382.1 MB
Notification: Performance of matching and sorting (n=453): time 0.01203/0.4473, allocations: 9.034 MB / 0.5472 GB, free: 13.69 MB / 382.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.324e-05/0.4474, allocations: 180.1 kB / 0.5474 GB, free: 13.48 MB / 382.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001859/0.4493, allocations: 1.476 MB / 0.5488 GB, free: 12.03 MB / 382.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0005252/0.4498, allocations: 137.7 kB / 0.549 GB, free: 11.89 MB / 382.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0004763/0.4503, allocations: 0.8466 MB / 0.5498 GB, free: 11.06 MB / 382.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.000968/0.4513, allocations: 1.446 MB / 0.5512 GB, free: 9.633 MB / 382.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001086/0.4524, allocations: 0.7463 MB / 0.5519 GB, free: 8.875 MB / 382.1 MB
Notification: Performance of setup shared object (initialization): time 6.543e-05/0.4525, allocations: 306.1 kB / 0.5522 GB, free: 8.574 MB / 382.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003084/0.4555, allocations: 2.438 MB / 0.5546 GB, free: 6.129 MB / 382.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003365/0.4589, allocations: 2.765 MB / 0.5573 GB, free: 3.328 MB / 382.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007248/0.4662, allocations: 5.305 MB / 0.5625 GB, free: 13.95 MB / 398.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.162e-05/0.4662, allocations: 8 kB / 0.5625 GB, free: 13.95 MB / 398.1 MB
Notification: Performance of matching and sorting (n=590) (initialization): time 0.01417/0.4804, allocations: 7.904 MB / 0.5702 GB, free: 5.953 MB / 398.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.728e-05/0.4805, allocations: 4 kB / 0.5702 GB, free: 5.949 MB / 398.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.602e-05/0.4805, allocations: 0 / 0.5702 GB, free: 5.949 MB / 398.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0439/0.5244, allocations: 21.49 MB / 0.5912 GB, free: 460 kB / 414.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00239/0.5268, allocations: 0.5461 MB / 0.5917 GB, free: 15.9 MB / 430.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01556/0.5424, allocations: 6.86 MB / 0.5984 GB, free: 9.004 MB / 430.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003364/0.5458, allocations: 412.8 kB / 0.5988 GB, free: 8.598 MB / 430.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005265/0.5464, allocations: 152 kB / 0.599 GB, free: 8.449 MB / 430.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1
 * Number of states: 0 ()
 * Number of discrete variables: 60 (b61106.degradedMode,$PRE.b61106.degradedMode,b87656.degradedMode,$PRE.b87656.degradedMode,b56131.degradedMode,$PRE.b56131.degradedMode,b61275.degradedMode,$PRE.b61275.degradedMode,b61273.degradedMode,$PRE.b61273.degradedMode,b61274.degradedMode,$PRE.b61274.degradedMode,b61089.degradedMode,$PRE.b61089.degradedMode,b61227.degradedMode,$PRE.b61227.degradedMode,b11403.degradedMode,$PRE.b11403.degradedMode,b11407.degradedMode,$PRE.b11407.degradedMode,b61254.degradedMode,$PRE.b61254.degradedMode,b61260.degradedMode,$PRE.b61260.degradedMode,b11465.degradedMode,$PRE.b11465.degradedMode,b87694.degradedMode,$PRE.b87694.degradedMode,b61121.degradedMode,$PRE.b61121.degradedMode,b61232.degradedMode,$PRE.b61232.degradedMode,b11480.degradedMode,$PRE.b11480.degradedMode,b61256.degradedMode,$PRE.b61256.degradedMode,b11458.degradedMode,$PRE.b11458.degradedMode,b61280.degradedMode,$PRE.b61280.degradedMode,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (375):
 * Single equations (assignments): 374
 * 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
   {(79,137)}
Notification: Performance of prepare postOptimizeDAE: time 0.001508/0.5479, allocations: 0.5337 MB / 0.5995 GB, free: 7.906 MB / 430.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008647/0.5488, allocations: 300.4 kB / 0.5998 GB, free: 7.609 MB / 430.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01333/0.5621, allocations: 7.784 MB / 0.6074 GB, free: 15.81 MB / 446.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.986e-05/0.5622, allocations: 23.91 kB / 0.6074 GB, free: 15.79 MB / 446.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.011e-05/0.5622, allocations: 0 / 0.6074 GB, free: 15.79 MB / 446.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.001893/0.5641, allocations: 0.9606 MB / 0.6083 GB, free: 14.8 MB / 446.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006031/0.5647, allocations: 84 kB / 0.6084 GB, free: 14.72 MB / 446.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002989/0.5677, allocations: 264.8 kB / 0.6087 GB, free: 14.47 MB / 446.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006966/0.5684, allocations: 307.5 kB / 0.609 GB, free: 14.17 MB / 446.1 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0234/0.5918, allocations: 8.27 MB / 0.617 GB, free: 6.027 MB / 446.1 MB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01313/0.605, allocations: 7.609 MB / 0.6245 GB, free: 14.39 MB / 462.1 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003599/0.6086, allocations: 2.227 MB / 0.6266 GB, free: 12.16 MB / 462.1 MB
Notification: Performance of sorting global known variables: time 0.001565/0.6102, allocations: 0.9307 MB / 0.6276 GB, free: 11.24 MB / 462.1 MB
Notification: Performance of Backend: time 3.2e-07/0.6102, allocations: 3.938 kB / 0.6276 GB, free: 11.24 MB / 462.1 MB
Notification: Performance of simCode: created initialization part: time 0.01535/0.6256, allocations: 5.06 MB / 0.6325 GB, free: 6.199 MB / 462.1 MB
Notification: Performance of SimCode: time 0.009101/0.6347, allocations: 6.828 MB / 0.6392 GB, free: 15.35 MB / 478.1 MB
Notification: Performance of Templates: time 0.2848/0.9195, allocations: 71.84 MB / 0.7093 GB, free: 171.4 MB / 0.5137 GB
make -j1 -f PowerSysPro_PowerSysPro.Examples.LargerNetwork.makefile
(rm -f PowerSysPro_PowerSysPro.Examples.LargerNetwork.pipe ; mkfifo PowerSysPro_PowerSysPro.Examples.LargerNetwork.pipe ; head -c 1048576 < PowerSysPro_PowerSysPro.Examples.LargerNetwork.pipe >> ../files/PowerSysPro_PowerSysPro.Examples.LargerNetwork.sim & ./PowerSysPro_PowerSysPro.Examples.LargerNetwork  -abortSlowSimulation -alarm=480 -lv LOG_STATS > PowerSysPro_PowerSysPro.Examples.LargerNetwork.pipe 2>&1)