Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestGrids_noopt_ScalableTestGrids.Models.Type0.Type0_N_1_M_1.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 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo", uses=false)
Using package ScalableTestGrids with version 1.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo)
Using package PowerGrids with version 1.0.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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: "" <> buildModelFMU(ScalableTestGrids.Models.Type0.Type0_N_1_M_1,fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids_Models_Type0_Type0_N_1_M_1",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ScalableTestGrids.Models.Type0.Type0_N_1_M_1,fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids_Models_Type0_Type0_N_1_M_1",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001066/0.001066, allocations: 115.4 kB / 17.74 MB, free: 5.332 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.0009798/0.0009798, allocations: 187 kB / 18.68 MB, free: 4.398 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.415/1.415, allocations: 205.1 MB / 224.6 MB, free: 12.24 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo): time 0.06275/0.06274, allocations: 14.17 MB / 286.1 MB, free: 13.86 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo): time 3.186/3.186, allocations: 461.2 MB / 0.7794 GB, free: 107.1 MB / 0.6545 GB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: ScalableTestGrids requested package PowerGrids of version 1.0.2. PowerGrids 1.0.3 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.001774/0.001774, allocations: 99.05 kB / 1.13 GB, free: 22.66 MB / 0.8735 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3122/0.314, allocations: 172.1 MB / 1.298 GB, free: 8.215 MB / 0.9829 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type0.Type0_N_1_M_1): time 0.03722/0.3513, allocations: 45.47 MB / 1.342 GB, free: 10.57 MB / 1.03 GB
Notification: Performance of NFInst.instExpressions: time 0.03041/0.3817, allocations: 16.19 MB / 1.358 GB, free: 10.32 MB / 1.045 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.009379/0.3911, allocations: 127.6 kB / 1.358 GB, free: 10.2 MB / 1.045 GB
Notification: Performance of NFTyping.typeComponents: time 0.008509/0.3997, allocations: 2.392 MB / 1.361 GB, free: 7.793 MB / 1.045 GB
Notification: Performance of NFTyping.typeBindings: time 0.02416/0.4239, allocations: 7.337 MB / 1.368 GB, free: 444 kB / 1.045 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004426/0.4283, allocations: 1.013 MB / 1.369 GB, free: 15.42 MB / 1.061 GB
Notification: Performance of NFFlatten.flatten: time 0.02186/0.4502, allocations: 14.06 MB / 1.382 GB, free: 1.301 MB / 1.061 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002882/0.4531, allocations: 1.02 MB / 1.383 GB, free: 248 kB / 1.061 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.009323/0.4625, allocations: 4.72 MB / 1.388 GB, free: 11.5 MB / 1.077 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01006/0.4726, allocations: 5.059 MB / 1.393 GB, free: 6.422 MB / 1.077 GB
Notification: Performance of NFPackage.collectConstants: time 0.002515/0.4751, allocations: 500 kB / 1.393 GB, free: 5.934 MB / 1.077 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006624/0.4818, allocations: 1.351 MB / 1.395 GB, free: 4.586 MB / 1.077 GB
Notification: Performance of NFScalarize.scalarize: time 0.002504/0.4843, allocations: 1.236 MB / 1.396 GB, free: 3.344 MB / 1.077 GB
Notification: Performance of NFVerifyModel.verify: time 0.008867/0.4932, allocations: 4.233 MB / 1.4 GB, free: 15.09 MB / 1.092 GB
Notification: Performance of NFConvertDAE.convert: time 0.01798/0.5112, allocations: 10.2 MB / 1.41 GB, free: 4.852 MB / 1.092 GB
Notification: Performance of FrontEnd - DAE generated: time 6.662e-06/0.5113, allocations: 4 kB / 1.41 GB, free: 4.848 MB / 1.092 GB
Notification: Performance of FrontEnd: time 2.014e-06/0.5113, allocations: 0 / 1.41 GB, free: 4.848 MB / 1.092 GB
Notification: Performance of Transformations before backend: time 0.0003775/0.5117, allocations: 0 / 1.41 GB, free: 4.848 MB / 1.092 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1484
 * Number of variables: 1484
Notification: Performance of Generate backend data structure: time 0.04536/0.557, allocations: 11.2 MB / 1.421 GB, free: 9.551 MB / 1.108 GB
Notification: Performance of prepare preOptimizeDAE: time 4.661e-05/0.5571, allocations: 8.031 kB / 1.421 GB, free: 9.543 MB / 1.108 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001887/0.559, allocations: 0.7464 MB / 1.422 GB, free: 8.785 MB / 1.108 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006231/0.5652, allocations: 1.152 MB / 1.423 GB, free: 7.629 MB / 1.108 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01097/0.5762, allocations: 4.206 MB / 1.427 GB, free: 3.363 MB / 1.108 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004602/0.5767, allocations: 428 kB / 1.427 GB, free: 2.945 MB / 1.108 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001449/0.5782, allocations: 0.5472 MB / 1.428 GB, free: 2.398 MB / 1.108 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01236/0.5906, allocations: 5.822 MB / 1.434 GB, free: 12.35 MB / 1.124 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001041/0.5907, allocations: 7.938 kB / 1.434 GB, free: 12.34 MB / 1.124 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004735/0.5912, allocations: 240 kB / 1.434 GB, free: 12.11 MB / 1.124 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001019/0.5913, allocations: 148 kB / 1.434 GB, free: 11.96 MB / 1.124 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01044/0.6018, allocations: 5.707 MB / 1.44 GB, free: 6.25 MB / 1.124 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.0571/0.6589, allocations: 39.06 MB / 1.478 GB, free: 11.33 MB / 1.17 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0122/0.6711, allocations: 7.562 MB / 1.485 GB, free: 3.684 MB / 1.17 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003675/0.6748, allocations: 2.414 MB / 1.487 GB, free: 1.258 MB / 1.17 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002584/0.6751, allocations: 80.66 kB / 1.487 GB, free: 1.176 MB / 1.17 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.36e-05/0.6752, allocations: 95.19 kB / 1.488 GB, free: 1.07 MB / 1.17 GB
Notification: Performance of pre-optimization done (n=597): time 7.554e-06/0.6752, allocations: 192 / 1.488 GB, free: 1.07 MB / 1.17 GB
Notification: Performance of matching and sorting (n=597): time 0.05447/0.7297, allocations: 16.04 MB / 1.503 GB, free: 0.8906 MB / 1.186 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.74e-05/0.7298, allocations: 112.1 kB / 1.503 GB, free: 0.7656 MB / 1.186 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00659/0.7364, allocations: 3.883 MB / 1.507 GB, free: 12.88 MB / 1.202 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007553/0.7372, allocations: 117.7 kB / 1.507 GB, free: 12.76 MB / 1.202 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002082/0.7393, allocations: 2.673 MB / 1.51 GB, free: 10.06 MB / 1.202 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002676/0.742, allocations: 2.145 MB / 1.512 GB, free: 7.898 MB / 1.202 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001668/0.7437, allocations: 1.077 MB / 1.513 GB, free: 6.812 MB / 1.202 GB
Notification: Performance of setup shared object (initialization): time 0.0001003/0.7438, allocations: 309.1 kB / 1.513 GB, free: 6.508 MB / 1.202 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002955/0.7467, allocations: 1.766 MB / 1.515 GB, free: 4.738 MB / 1.202 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003971/0.7507, allocations: 3.155 MB / 1.518 GB, free: 1.059 MB / 1.202 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007972/0.7587, allocations: 5.338 MB / 1.523 GB, free: 11.14 MB / 1.217 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.905e-05/0.7588, allocations: 12 kB / 1.523 GB, free: 11.12 MB / 1.217 GB
Notification: Performance of matching and sorting (n=858) (initialization): time 0.01431/0.7731, allocations: 7.255 MB / 1.53 GB, free: 3.797 MB / 1.217 GB
Notification: Performance of prepare postOptimizeDAE: time 4.493e-05/0.7731, allocations: 20 kB / 1.53 GB, free: 3.777 MB / 1.217 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.394e-05/0.7732, allocations: 40 kB / 1.53 GB, free: 3.738 MB / 1.217 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01055/0.7838, allocations: 2.257 MB / 1.533 GB, free: 1.473 MB / 1.217 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006243/0.79, allocations: 1.494 MB / 1.534 GB, free: 15.97 MB / 1.233 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02926/0.8193, allocations: 15.14 MB / 1.549 GB, free: 0.543 MB / 1.233 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007902/0.8272, allocations: 481.1 kB / 1.549 GB, free: 72 kB / 1.233 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001004/0.8283, allocations: 252.1 kB / 1.55 GB, free: 15.82 MB / 1.249 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 172
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (710):
 * Single equations (assignments): 708
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(136,0), (14,0)}
Notification: Performance of prepare postOptimizeDAE: time 0.003535/0.8318, allocations: 1.024 MB / 1.551 GB, free: 14.79 MB / 1.249 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002342/0.8342, allocations: 0.594 MB / 1.551 GB, free: 14.19 MB / 1.249 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01134/0.8455, allocations: 6.025 MB / 1.557 GB, free: 8.062 MB / 1.249 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.244e-05/0.8456, allocations: 64 kB / 1.557 GB, free: 8 MB / 1.249 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.066e-05/0.8456, allocations: 3.938 kB / 1.557 GB, free: 7.996 MB / 1.249 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.103e-05/0.8457, allocations: 27.89 kB / 1.557 GB, free: 7.969 MB / 1.249 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 postOpt removeSimpleEquations (simulation): time 0.02307/0.8688, allocations: 13.35 MB / 1.57 GB, free: 10.27 MB / 1.264 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.819e-05/0.8688, allocations: 4 kB / 1.57 GB, free: 10.26 MB / 1.264 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.004491/0.8733, allocations: 1.05 MB / 1.571 GB, free: 9.211 MB / 1.264 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003627/0.877, allocations: 0.8558 MB / 1.572 GB, free: 8.348 MB / 1.264 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0004342/0.8774, allocations: 104 kB / 1.572 GB, free: 8.246 MB / 1.264 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02527/0.9027, allocations: 14.82 MB / 1.587 GB, free: 9.117 MB / 1.28 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.204e-06/0.9028, allocations: 7.938 kB / 1.587 GB, free: 9.109 MB / 1.28 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 1.211/2.114, allocations: 9.89 MB / 1.596 GB, free: 269.4 MB / 1.28 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005127/2.119, allocations: 1.208 MB / 1.597 GB, free: 269.3 MB / 1.28 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001886/2.121, allocations: 102.5 kB / 1.598 GB, free: 269.3 MB / 1.28 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006782/2.128, allocations: 145.2 kB / 1.598 GB, free: 269.3 MB / 1.28 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001918/2.13, allocations: 388.2 kB / 1.598 GB, free: 269.3 MB / 1.28 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003967/2.13, allocations: 144.6 kB / 1.598 GB, free: 269.3 MB / 1.28 GB
Notification: Performance of sorting global known variables: time 0.006833/2.137, allocations: 2.507 MB / 1.601 GB, free: 269.1 MB / 1.28 GB
Notification: Performance of sort global known variables: time 6.71e-07/2.137, allocations: 0 / 1.601 GB, free: 269.1 MB / 1.28 GB
Notification: Performance of remove unused functions: time 0.01089/2.148, allocations: 2.248 MB / 1.603 GB, free: 269.1 MB / 1.28 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 17
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (451):
 * Single equations (assignments): 449
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * 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): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(14,0), (134,0)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01672/2.164, allocations: 7.08 MB / 1.61 GB, free: 267.1 MB / 1.28 GB
Notification: Performance of simCode: created initialization part: time 0.02084/2.185, allocations: 7.525 MB / 1.617 GB, free: 264.2 MB / 1.28 GB
Notification: Performance of simCode: created event and clocks part: time 1.328e-05/2.185, allocations: 4.844 kB / 1.617 GB, free: 264.2 MB / 1.28 GB
Notification: Performance of simCode: created simulation system equations: time 0.01245/2.198, allocations: 4.911 MB / 1.622 GB, free: 262.3 MB / 1.28 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.009108/2.207, allocations: 0.7303 MB / 1.623 GB, free: 261.9 MB / 1.28 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.09784/2.305, allocations: 45.32 MB / 1.667 GB, free: 239 MB / 1.28 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00419/2.309, allocations: 3.009 MB / 1.67 GB, free: 238.1 MB / 1.28 GB
Notification: Performance of simCode: alias equations: time 0.00393/2.313, allocations: 0.711 MB / 1.671 GB, free: 237.9 MB / 1.28 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004203/2.317, allocations: 2.429 MB / 1.673 GB, free: 235.8 MB / 1.28 GB
Notification: Performance of SimCode: time 1.232e-06/2.317, allocations: 0 / 1.673 GB, free: 235.8 MB / 1.28 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.2152/2.533, allocations: 131.4 MB / 1.801 GB, free: 105.5 MB / 1.28 GB
Notification: Performance of buildModelFMU: Generate platform static: time 27.69/30.22, allocations: 7.922 kB / 1.801 GB, free: 105.5 MB / 1.28 GB
(rm -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type0.Type0_N_1_M_1.pipe ; mkfifo ScalableTestGrids_noopt_ScalableTestGrids.Models.Type0.Type0_N_1_M_1.pipe ; head -c 1048576 < ScalableTestGrids_noopt_ScalableTestGrids.Models.Type0.Type0_N_1_M_1.pipe >> ../files/ScalableTestGrids_noopt_ScalableTestGrids.Models.Type0.Type0_N_1_M_1.sim & python3 -m fmpy simulate  --output-file ScalableTestGrids_noopt_ScalableTestGrids.Models.Type0.Type0_N_1_M_1_res.csv --start-time 0 --stop-time 1 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 1 ScalableTestGrids_noopt_ScalableTestGrids_Models_Type0_Type0_N_1_M_1.fmu > ScalableTestGrids_noopt_ScalableTestGrids.Models.Type0.Type0_N_1_M_1.pipe 2>&1)