Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001403/0.001403, allocations: 112.9 kB / 21.1 MB, free: 0.7695 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.002007/0.002007, allocations: 209.1 kB / 24.38 MB, free: 4.184 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.485/1.485, allocations: 230.2 MB / 257.7 MB, free: 8.289 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo): time 0.2493/0.2493, allocations: 46.93 MB / 361.1 MB, free: 4.461 MB / 286.1 MB
"
[Timeout remaining time 179]
Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: translateModel(ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|vC.2.|iL.1.|iL.2.|vC.3.|vC.1.|iL.3.",fileNamePrefix="ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep")
translateModel(ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|vC.2.|iL.1.|iL.2.|vC.3.|vC.1.|iL.3.",fileNamePrefix="ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep") [Timeout 660]
"Warning: Requested package Modelica of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions.
Notification: Performance of FrontEnd - loaded program: time 0.002398/0.002398, allocations: 79.86 kB / 0.4968 GB, free: 7.664 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.41/0.4124, allocations: 66.04 MB / 0.5612 GB, free: 4.551 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep): time 0.01368/0.4261, allocations: 9.449 MB / 0.5705 GB, free: 11.06 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.007072/0.4332, allocations: 2.846 MB / 0.5733 GB, free: 8.203 MB / 414.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002381/0.4356, allocations: 87.56 kB / 0.5733 GB, free: 8.117 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.009708/0.4453, allocations: 3.772 MB / 0.577 GB, free: 4.336 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.005186/0.4505, allocations: 1.1 MB / 0.5781 GB, free: 3.234 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002907/0.4534, allocations: 0.7947 MB / 0.5789 GB, free: 2.438 MB / 414.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007539/0.4609, allocations: 4.871 MB / 0.5836 GB, free: 13.55 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01539/0.4763, allocations: 7.37 MB / 0.5908 GB, free: 6.059 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.006229/0.4825, allocations: 2.849 MB / 0.5936 GB, free: 3.203 MB / 430.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.006439/0.489, allocations: 3.154 MB / 0.5967 GB, free: 40 kB / 430.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.003093/0.4921, allocations: 0.7657 MB / 0.5974 GB, free: 15.27 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003866/0.4959, allocations: 0.9295 MB / 0.5983 GB, free: 14.34 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.003489/0.4994, allocations: 1.617 MB / 0.5999 GB, free: 12.72 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.00667/0.5061, allocations: 3.004 MB / 0.6029 GB, free: 9.707 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01518/0.5213, allocations: 10.49 MB / 0.6131 GB, free: 15.18 MB / 462.1 MB
Notification: Performance of FrontEnd - DAE generated: time 9.128e-06/0.5213, allocations: 0 / 0.6131 GB, free: 15.18 MB / 462.1 MB
Notification: Performance of FrontEnd: time 2.013e-06/0.5213, allocations: 0 / 0.6131 GB, free: 15.18 MB / 462.1 MB
Notification: Performance of Transformations before backend: time 0.0004677/0.5217, allocations: 3.938 kB / 0.6131 GB, free: 15.18 MB / 462.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1440
 * Number of variables: 1440
Notification: Performance of Generate backend data structure: time 0.02574/0.5475, allocations: 6.343 MB / 0.6193 GB, free: 8.781 MB / 462.1 MB
Notification: Performance of prepare preOptimizeDAE: time 6.43e-05/0.5475, allocations: 8.031 kB / 0.6193 GB, free: 8.773 MB / 462.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02439/0.5719, allocations: 3.93 MB / 0.6231 GB, free: 4.836 MB / 462.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.008602/0.5805, allocations: 3.265 MB / 0.6263 GB, free: 1.531 MB / 462.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006321/0.5812, allocations: 390.5 kB / 0.6267 GB, free: 1.148 MB / 462.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003037/0.5842, allocations: 0.4961 MB / 0.6272 GB, free: 0.6523 MB / 462.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02737/0.6116, allocations: 8.7 MB / 0.6357 GB, free: 7.91 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003958/0.612, allocations: 11.83 kB / 0.6357 GB, free: 7.898 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002678/0.6147, allocations: 220 kB / 0.6359 GB, free: 7.684 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0006114/0.6153, allocations: 339.1 kB / 0.6362 GB, free: 7.348 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02244/0.6377, allocations: 8.039 MB / 0.6441 GB, free: 15.29 MB / 494.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.06201/0.6997, allocations: 25.15 MB / 0.6686 GB, free: 5.59 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01294/0.7127, allocations: 4.562 MB / 0.6731 GB, free: 1.125 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003239/0.7159, allocations: 1.487 MB / 0.6745 GB, free: 15.63 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002836/0.7162, allocations: 65.91 kB / 0.6746 GB, free: 15.57 MB / 0.5137 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.578e-05/0.7163, allocations: 72.48 kB / 0.6747 GB, free: 15.49 MB / 0.5137 GB
Notification: Performance of pre-optimization done (n=214): time 6.201e-06/0.7163, allocations: 7.984 kB / 0.6747 GB, free: 15.48 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=214): time 0.007114/0.7234, allocations: 3.515 MB / 0.6781 GB, free: 11.96 MB / 0.5137 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001025/0.7235, allocations: 107.1 kB / 0.6782 GB, free: 11.84 MB / 0.5137 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.006965/0.7304, allocations: 3.43 MB / 0.6816 GB, free: 8.387 MB / 0.5137 GB
Notification: Performance of collectPreVariables (initialization): time 0.0004355/0.7309, allocations: 57.7 kB / 0.6816 GB, free: 8.324 MB / 0.5137 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002296/0.7332, allocations: 2.234 MB / 0.6838 GB, free: 6.07 MB / 0.5137 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001371/0.7345, allocations: 0.7748 MB / 0.6846 GB, free: 5.289 MB / 0.5137 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002023/0.7366, allocations: 0.7069 MB / 0.6853 GB, free: 4.574 MB / 0.5137 GB
Notification: Performance of setup shared object (initialization): time 0.0001442/0.7367, allocations: 309.1 kB / 0.6855 GB, free: 4.27 MB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00322/0.7399, allocations: 1.564 MB / 0.6871 GB, free: 2.703 MB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004913/0.7448, allocations: 3.187 MB / 0.6902 GB, free: 14.75 MB / 0.5294 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.008452/0.7533, allocations: 5.079 MB / 0.6951 GB, free: 8.891 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.605e-05/0.7534, allocations: 16 kB / 0.6952 GB, free: 8.875 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=442) (initialization): time 0.01243/0.7658, allocations: 4.956 MB / 0.7 GB, free: 3.91 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001219/0.7659, allocations: 28 kB / 0.7 GB, free: 3.883 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001928/0.7661, allocations: 56 kB / 0.7001 GB, free: 3.828 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001543/0.7663, allocations: 76 kB / 0.7002 GB, free: 3.754 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004078/0.7704, allocations: 0.9209 MB / 0.7011 GB, free: 2.832 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001556/0.7705, allocations: 111.6 kB / 0.7012 GB, free: 2.723 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003833/0.7743, allocations: 0.5741 MB / 0.7017 GB, free: 2.145 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007109/0.7751, allocations: 192 kB / 0.7019 GB, free: 1.957 MB / 0.5294 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 252
 * 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 (442):
 * Single equations (assignments): 442
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.005499/0.7806, allocations: 2.077 MB / 0.7039 GB, free: 15.86 MB / 0.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000868/0.7814, allocations: 286.1 kB / 0.7042 GB, free: 15.58 MB / 0.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006713/0.7881, allocations: 3.176 MB / 0.7073 GB, free: 12.38 MB / 0.545 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.215e-05/0.7882, allocations: 24 kB / 0.7073 GB, free: 12.36 MB / 0.545 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.453e-05/0.7882, allocations: 0 / 0.7073 GB, free: 12.36 MB / 0.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.62e-05/0.7882, allocations: 15.95 kB / 0.7073 GB, free: 12.34 MB / 0.545 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01834/0.8065, allocations: 8.634 MB / 0.7158 GB, free: 3.426 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.502e-05/0.8066, allocations: 16 kB / 0.7158 GB, free: 3.41 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002287/0.8089, allocations: 0.5696 MB / 0.7163 GB, free: 2.84 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (simulation): time 5.825e-05/0.8089, allocations: 28 kB / 0.7164 GB, free: 2.812 MB / 0.545 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002566/0.8092, allocations: 75.98 kB / 0.7164 GB, free: 2.738 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 4.506e-05/0.8092, allocations: 35.86 kB / 0.7165 GB, free: 2.703 MB / 0.545 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.414e-05/0.8093, allocations: 27.88 kB / 0.7165 GB, free: 2.676 MB / 0.545 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.009844/0.8191, allocations: 5.268 MB / 0.7217 GB, free: 13.08 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001983/0.8211, allocations: 0.6496 MB / 0.7223 GB, free: 12.43 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0008041/0.8219, allocations: 75.94 kB / 0.7224 GB, free: 12.36 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001902/0.8238, allocations: 119.9 kB / 0.7225 GB, free: 12.24 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005535/0.8243, allocations: 237.2 kB / 0.7227 GB, free: 12 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002035/0.8245, allocations: 95.97 kB / 0.7228 GB, free: 11.91 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.00527/0.8298, allocations: 2.384 MB / 0.7251 GB, free: 9.516 MB / 0.5606 GB
Notification: Performance of sort global known variables: time 1.21e-07/0.8298, allocations: 0 / 0.7251 GB, free: 9.516 MB / 0.5606 GB
Notification: Performance of remove unused functions: time 0.005424/0.8352, allocations: 1.11 MB / 0.7262 GB, free: 8.402 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 73
 * Number of states: 2 (currentSource.currentSource.plug_p.reference.gamma,voltageSource.voltageSource.plug_p.reference.gamma)
 * 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 (275):
 * Single equations (assignments): 275
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0007981/0.836, allocations: 230.3 kB / 0.7264 GB, free: 8.168 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.007962/0.844, allocations: 3.478 MB / 0.7298 GB, free: 4.688 MB / 0.5606 GB
Notification: Performance of simCode: created event and clocks part: time 1.725e-05/0.844, allocations: 0 / 0.7298 GB, free: 4.688 MB / 0.5606 GB
Notification: Performance of simCode: created simulation system equations: time 0.003096/0.8471, allocations: 1.479 MB / 0.7313 GB, free: 3.215 MB / 0.5606 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004479/0.8516, allocations: 0.5211 MB / 0.7318 GB, free: 2.703 MB / 0.5606 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3562/1.208, allocations: 9.367 MB / 0.7409 GB, free: 148.8 MB / 0.5606 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004696/1.213, allocations: 3.635 MB / 0.7445 GB, free: 147.8 MB / 0.5606 GB
Notification: Performance of simCode: alias equations: time 0.003401/1.216, allocations: 1.473 MB / 0.7459 GB, free: 147.7 MB / 0.5606 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007072/1.217, allocations: 261.2 kB / 0.7462 GB, free: 147.7 MB / 0.5606 GB
Notification: Performance of SimCode: time 1.122e-06/1.217, allocations: 0 / 0.7462 GB, free: 147.7 MB / 0.5606 GB
Notification: Performance of Templates: time 0.06174/1.278, allocations: 39.68 MB / 0.7849 GB, free: 113.7 MB / 0.5606 GB
"
[Timeout remaining time 659]
make -j1 -f ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep.makefile [Timeout 660]
(rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep.sim & ./ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep.pipe 2>&1) [Timeout 480]
diffSimulationResults("ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/ModelicaTest/Electrical/QuasiStatic/Polyphase/FrequencySweep/FrequencySweep.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_4.1.0-beta.om_ModelicaTest.Electrical.QuasiStatic.Polyphase.FrequencySweep.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 660]
Reference file matches
[Calling sys.exit(0), Time elapsed: 7.4143101349473]