Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.Components.PolyphaseInductance.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.001776/0.001776, allocations: 117.8 kB / 18.5 MB, free: 4.434 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.002538/0.002538, allocations: 216.9 kB / 21.47 MB, free: 1.473 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0-beta.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0-beta.om/package.mo): time 1.482/1.482, allocations: 230.4 MB / 254.7 MB, free: 15.01 MB / 206.1 MB
"
[Timeout remaining time 178]
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0-beta.om/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: "" <> buildModelFMU(Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.Components.PolyphaseInductance,fileNamePrefix="Modelica_4_1_0-beta_om_Modelica_Magnetic_QuasiStatic_FundamentalWave_Examples_Components_PolyphaseInductance",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.Components.PolyphaseInductance,fileNamePrefix="Modelica_4_1_0-beta_om_Modelica_Magnetic_QuasiStatic_FundamentalWave_Examples_Components_PolyphaseInductance",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Warning: Requested package Modelica of version trunk, but this package was already loaded with version 4.1.0. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions.
Warning: Requested package Complex 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.
Warning: Requested package ModelicaServices 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.001948/0.001948, allocations: 71.83 kB / 373.6 MB, free: 10.25 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.102/0.1039, allocations: 53.32 MB / 426.9 MB, free: 4.84 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.Components.PolyphaseInductance): time 0.2081/0.312, allocations: 10.05 MB / 436.9 MB, free: 6.043 MB / 350.1 MB
Notification: Performance of NFInst.instExpressions: time 0.007124/0.3191, allocations: 3.403 MB / 440.3 MB, free: 4.531 MB / 350.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001613/0.3208, allocations: 71.34 kB / 440.4 MB, free: 4.52 MB / 350.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.007972/0.3287, allocations: 3.864 MB / 444.3 MB, free: 2.234 MB / 350.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.005125/0.3338, allocations: 1.499 MB / 445.8 MB, free: 1.363 MB / 350.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002485/0.3363, allocations: 1.064 MB / 446.8 MB, free: 0.7305 MB / 350.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01193/0.3483, allocations: 9.26 MB / 456.1 MB, free: 12.13 MB / 366.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.02395/0.3722, allocations: 15.82 MB / 471.9 MB, free: 4.004 MB / 366.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.008628/0.3808, allocations: 5.07 MB / 477 MB, free: 14.92 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.01042/0.3913, allocations: 6.153 MB / 483.1 MB, free: 8.75 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.00439/0.3956, allocations: 1.395 MB / 484.5 MB, free: 7.355 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.006584/0.4022, allocations: 1.652 MB / 486.2 MB, free: 5.703 MB / 382.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.005049/0.4073, allocations: 2.927 MB / 489.1 MB, free: 2.766 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.01072/0.418, allocations: 5.451 MB / 494.6 MB, free: 13.29 MB / 398.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.02415/0.4422, allocations: 18.91 MB / 0.5014 GB, free: 10.32 MB / 414.1 MB
Notification: Performance of FrontEnd - DAE generated: time 8.676e-06/0.4422, allocations: 4 kB / 0.5014 GB, free: 10.32 MB / 414.1 MB
Notification: Performance of FrontEnd: time 2.144e-06/0.4422, allocations: 0 / 0.5014 GB, free: 10.32 MB / 414.1 MB
Notification: Performance of Transformations before backend: time 0.0004614/0.4426, allocations: 0 / 0.5014 GB, free: 10.32 MB / 414.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2549
 * Number of variables: 2549
Notification: Performance of Generate backend data structure: time 0.03681/0.4794, allocations: 12.46 MB / 0.5136 GB, free: 13.77 MB / 430.1 MB
Notification: Performance of prepare preOptimizeDAE: time 6.238e-05/0.4795, allocations: 12.03 kB / 0.5136 GB, free: 13.76 MB / 430.1 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.004905/0.4844, allocations: 1.328 MB / 0.5149 GB, free: 12.42 MB / 430.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04916/0.5336, allocations: 8.417 MB / 0.5231 GB, free: 3.988 MB / 430.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01708/0.5506, allocations: 5.911 MB / 0.5289 GB, free: 14.01 MB / 446.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007756/0.5514, allocations: 0.6623 MB / 0.5296 GB, free: 13.35 MB / 446.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003639/0.555, allocations: 0.8632 MB / 0.5304 GB, free: 12.48 MB / 446.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.04079/0.5958, allocations: 16.02 MB / 0.546 GB, free: 12.42 MB / 462.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002957/0.5961, allocations: 11.89 kB / 0.5461 GB, free: 12.41 MB / 462.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002338/0.5985, allocations: 364 kB / 0.5464 GB, free: 12.05 MB / 462.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000599/0.5991, allocations: 0.5582 MB / 0.547 GB, free: 11.49 MB / 462.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03202/0.6311, allocations: 15.77 MB / 0.5624 GB, free: 11.7 MB / 478.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.09199/0.7231, allocations: 48.68 MB / 0.6099 GB, free: 9.641 MB / 0.5137 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.225/0.948, allocations: 18.87 MB / 0.6283 GB, free: 142 MB / 0.5137 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005961/0.954, allocations: 3.246 MB / 0.6315 GB, free: 141.9 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0006296/0.9546, allocations: 300.4 kB / 0.6318 GB, free: 141.7 MB / 0.5137 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.466e-05/0.9547, allocations: 91.41 kB / 0.6319 GB, free: 141.6 MB / 0.5137 GB
Notification: Performance of pre-optimization done (n=468): time 8.235e-06/0.9547, allocations: 0 / 0.6319 GB, free: 141.6 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=468): time 0.02527/0.98, allocations: 11.55 MB / 0.6431 GB, free: 137.8 MB / 0.5137 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.132e-05/0.9801, allocations: 125.5 kB / 0.6433 GB, free: 137.7 MB / 0.5137 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.006041/0.9861, allocations: 3.849 MB / 0.647 GB, free: 136.5 MB / 0.5137 GB
Notification: Performance of collectPreVariables (initialization): time 0.0009121/0.987, allocations: 102.3 kB / 0.6471 GB, free: 136.4 MB / 0.5137 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001956/0.989, allocations: 4.049 MB / 0.6511 GB, free: 133.4 MB / 0.5137 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001709/0.9907, allocations: 1.689 MB / 0.6527 GB, free: 132.1 MB / 0.5137 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002207/0.9929, allocations: 1.486 MB / 0.6542 GB, free: 131.4 MB / 0.5137 GB
Notification: Performance of setup shared object (initialization): time 5.274e-05/0.993, allocations: 306.3 kB / 0.6545 GB, free: 131.1 MB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004979/0.9979, allocations: 3.698 MB / 0.6581 GB, free: 129.8 MB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006427/1.004, allocations: 6.523 MB / 0.6644 GB, free: 124.9 MB / 0.5137 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01129/1.016, allocations: 10.86 MB / 0.6751 GB, free: 117.8 MB / 0.5137 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001481/1.016, allocations: 31.12 kB / 0.6751 GB, free: 117.8 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=938) (initialization): time 0.02025/1.036, allocations: 11.96 MB / 0.6868 GB, free: 111.4 MB / 0.5137 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001366/1.036, allocations: 48 kB / 0.6868 GB, free: 111.4 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001792/1.036, allocations: 98.12 kB / 0.6869 GB, free: 111.3 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004501/1.041, allocations: 1.612 MB / 0.6885 GB, free: 109.9 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006613/1.047, allocations: 1.673 MB / 0.6901 GB, free: 108.2 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01589/1.063, allocations: 17.68 MB / 0.7074 GB, free: 89.71 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006008/1.069, allocations: 0.9702 MB / 0.7083 GB, free: 88.73 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001528/1.071, allocations: 371.5 kB / 0.7087 GB, free: 88.38 MB / 0.5137 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 424
 * 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 (876):
 * Single equations (assignments): 870
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 6
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 6 systems
   {(8,30,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.00712/1.078, allocations: 3.754 MB / 0.7123 GB, free: 84.61 MB / 0.5137 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00134/1.079, allocations: 409.4 kB / 0.7127 GB, free: 84.2 MB / 0.5137 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01502/1.094, allocations: 8.53 MB / 0.7211 GB, free: 75.59 MB / 0.5137 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.605e-05/1.094, allocations: 52 kB / 0.7211 GB, free: 75.54 MB / 0.5137 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.338e-05/1.094, allocations: 12 kB / 0.7211 GB, free: 75.52 MB / 0.5137 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.166e-05/1.095, allocations: 27.84 kB / 0.7212 GB, free: 75.5 MB / 0.5137 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02746/1.122, allocations: 16.79 MB / 0.7376 GB, free: 58.67 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.482e-05/1.122, allocations: 4 kB / 0.7376 GB, free: 58.66 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003074/1.125, allocations: 0.8659 MB / 0.7384 GB, free: 57.8 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003826/1.129, allocations: 1.515 MB / 0.7399 GB, free: 56.26 MB / 0.5137 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0005587/1.129, allocations: 104 kB / 0.74 GB, free: 56.16 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01438/1.144, allocations: 17.47 MB / 0.757 GB, free: 37.87 MB / 0.5137 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.447e-06/1.144, allocations: 4 kB / 0.757 GB, free: 37.87 MB / 0.5137 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01641/1.16, allocations: 12.25 MB / 0.769 GB, free: 25.41 MB / 0.5137 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003436/1.164, allocations: 1.122 MB / 0.7701 GB, free: 24.26 MB / 0.5137 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001408/1.165, allocations: 91.5 kB / 0.7702 GB, free: 24.18 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003138/1.168, allocations: 299.7 kB / 0.7705 GB, free: 23.88 MB / 0.5137 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001121/1.169, allocations: 323.6 kB / 0.7708 GB, free: 23.57 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0006815/1.17, allocations: 148 kB / 0.7709 GB, free: 23.42 MB / 0.5137 GB
Notification: Performance of sorting global known variables: time 0.004517/1.175, allocations: 2.574 MB / 0.7734 GB, free: 20.85 MB / 0.5137 GB
Notification: Performance of sort global known variables: time 6e-08/1.175, allocations: 0 / 0.7734 GB, free: 20.85 MB / 0.5137 GB
Notification: Performance of remove unused functions: time 0.00873/1.183, allocations: 2.411 MB / 0.7758 GB, free: 18.43 MB / 0.5137 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 10
 * Number of states: 2 (voltageSource_m.plug_p.reference.gamma,voltageSource_e.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 (455):
 * 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: 6
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 6 systems
   {(8,30,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%), (1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.01987/1.203, allocations: 12.98 MB / 0.7885 GB, free: 5.227 MB / 0.5137 GB
Notification: Performance of simCode: created initialization part: time 0.01604/1.219, allocations: 9.006 MB / 0.7973 GB, free: 12.12 MB / 0.5294 GB
Notification: Performance of simCode: created event and clocks part: time 1.163e-05/1.219, allocations: 0 / 0.7973 GB, free: 12.12 MB / 0.5294 GB
Notification: Performance of simCode: created simulation system equations: time 0.008924/1.228, allocations: 4.186 MB / 0.8014 GB, free: 7.855 MB / 0.5294 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005777/1.234, allocations: 0.7396 MB / 0.8021 GB, free: 7.125 MB / 0.5294 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3465/1.58, allocations: 61.24 MB / 0.8619 GB, free: 159.9 MB / 0.545 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.005642/1.586, allocations: 6.051 MB / 0.8678 GB, free: 157.7 MB / 0.545 GB
Notification: Performance of simCode: alias equations: time 0.006423/1.592, allocations: 3.252 MB / 0.871 GB, free: 157 MB / 0.545 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003804/1.596, allocations: 3.069 MB / 0.874 GB, free: 154.3 MB / 0.545 GB
Notification: Performance of SimCode: time 1.202e-06/1.596, allocations: 0 / 0.874 GB, free: 154.3 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.1875/1.784, allocations: 127.2 MB / 0.9982 GB, free: 30.59 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate platform static: time 19.49/21.28, allocations: 14.25 kB / 0.9982 GB, free: 30.58 MB / 0.545 GB
"
[Timeout remaining time 639]
(rm -f Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.Components.PolyphaseInductance.pipe ; mkfifo Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.Components.PolyphaseInductance.pipe ; head -c 1048576 < Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.Components.PolyphaseInductance.pipe >> ../files/Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.Components.PolyphaseInductance.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.Components.PolyphaseInductance_res.mat --tempDir=temp_Modelica_4_1_0-beta_om_Modelica_Magnetic_QuasiStatic_FundamentalWave_Examples_Components_PolyphaseInductance_fmu --startTime=0 --stopTime=100 --stepSize=0.01 --timeout=50 --tolerance=1e-06 Modelica_4_1_0-beta_om_Modelica_Magnetic_QuasiStatic_FundamentalWave_Examples_Components_PolyphaseInductance.fmu > Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.Components.PolyphaseInductance.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 23.94207000080496]
Failed to read output from testmodel.py, exit status != 0:
['time', 'Ie.re', 'Ie.im', 'Im.re', 'Im.im']
21.42402683524415 21.43862543 20.993106255
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f4c8f8e2020>