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.BasicMachines.InductionMachines.IMC_Initialize.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.001784/0.001784, allocations: 122.6 kB / 18.5 MB, free: 4.578 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.002056/0.002056, allocations: 206.6 kB / 21.45 MB, free: 1.629 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.488/1.488, allocations: 230.5 MB / 254.8 MB, free: 15.12 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.BasicMachines.InductionMachines.IMC_Initialize,fileNamePrefix="Modelica_4_1_0-beta_om_Modelica_Magnetic_QuasiStatic_FundamentalWave_Examples_BasicMachines_InductionMachines_IMC_Initialize",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.InductionMachines.IMC_Initialize,fileNamePrefix="Modelica_4_1_0-beta_om_Modelica_Magnetic_QuasiStatic_FundamentalWave_Examples_BasicMachines_InductionMachines_IMC_Initialize",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.003356/0.003356, allocations: 67.84 kB / 373.7 MB, free: 10.19 MB / 302.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1125/0.1159, allocations: 53.33 MB / 427 MB, free: 4.77 MB / 350.1 MB Notification: Performance of NFInst.instantiate(Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.InductionMachines.IMC_Initialize): time 0.2522/0.3682, allocations: 33.63 MB / 460.7 MB, free: 5.75 MB / 366.1 MB Notification: Performance of NFInst.instExpressions: time 0.02492/0.3931, allocations: 9.273 MB / 469.9 MB, free: 15.07 MB / 382.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.00899/0.4021, allocations: 289.4 kB / 470.2 MB, free: 14.98 MB / 382.1 MB Notification: Performance of NFTyping.typeComponents: time 0.02121/0.4233, allocations: 8.079 MB / 478.3 MB, free: 9.395 MB / 382.1 MB Notification: Performance of NFTyping.typeBindings: time 0.01524/0.4385, allocations: 3.742 MB / 482 MB, free: 6.387 MB / 382.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.008039/0.4466, allocations: 2.151 MB / 484.2 MB, free: 4.641 MB / 382.1 MB Notification: Performance of NFFlatten.flatten: time 0.02013/0.4667, allocations: 13.15 MB / 497.3 MB, free: 10.69 MB / 398.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.02997/0.4967, allocations: 16.89 MB / 0.5022 GB, free: 9.633 MB / 414.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.01349/0.5101, allocations: 6.694 MB / 0.5087 GB, free: 2.922 MB / 414.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.01501/0.5252, allocations: 7.464 MB / 0.516 GB, free: 11.43 MB / 430.1 MB Notification: Performance of NFPackage.collectConstants: time 0.005789/0.5309, allocations: 1.883 MB / 0.5179 GB, free: 9.547 MB / 430.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.007842/0.5388, allocations: 2.273 MB / 0.5201 GB, free: 7.277 MB / 430.1 MB Notification: Performance of NFScalarize.scalarize: time 0.006345/0.5451, allocations: 3.76 MB / 0.5237 GB, free: 3.508 MB / 430.1 MB Notification: Performance of NFVerifyModel.verify: time 0.01448/0.5596, allocations: 7.117 MB / 0.5307 GB, free: 12.36 MB / 446.1 MB Notification: Performance of NFConvertDAE.convert: time 0.03701/0.5966, allocations: 25.1 MB / 0.5552 GB, free: 3.184 MB / 462.1 MB Notification: Performance of FrontEnd - DAE generated: time 5.821e-06/0.5966, allocations: 0 / 0.5552 GB, free: 3.184 MB / 462.1 MB Notification: Performance of FrontEnd: time 1.803e-06/0.5966, allocations: 4 kB / 0.5552 GB, free: 3.18 MB / 462.1 MB Notification: Performance of Transformations before backend: time 0.0006673/0.5973, allocations: 0 / 0.5552 GB, free: 3.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: 2952 * Number of variables: 2952 Notification: Performance of Generate backend data structure: time 0.04881/0.6461, allocations: 14.89 MB / 0.5698 GB, free: 4.156 MB / 478.1 MB Notification: Performance of prepare preOptimizeDAE: time 4.908e-05/0.6461, allocations: 8.031 kB / 0.5698 GB, free: 4.148 MB / 478.1 MB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.005735/0.6519, allocations: 1.51 MB / 0.5712 GB, free: 2.625 MB / 478.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04181/0.6937, allocations: 6.806 MB / 0.5779 GB, free: 11.8 MB / 494.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.01942/0.7131, allocations: 8.161 MB / 0.5859 GB, free: 3.566 MB / 494.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001124/0.7142, allocations: 0.7907 MB / 0.5866 GB, free: 2.773 MB / 494.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.004692/0.7189, allocations: 1.047 MB / 0.5876 GB, free: 1.727 MB / 494.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.04656/0.7655, allocations: 17.26 MB / 0.6045 GB, free: 400 kB / 0.4981 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0004304/0.7659, allocations: 15.94 kB / 0.6045 GB, free: 384 kB / 0.4981 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003197/0.7691, allocations: 440 kB / 0.6049 GB, free: 15.94 MB / 0.5137 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0007331/0.7698, allocations: 0.6351 MB / 0.6056 GB, free: 15.3 MB / 0.5137 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.4595/1.229, allocations: 16.35 MB / 0.6215 GB, free: 143.9 MB / 0.5138 GB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.09491/1.324, allocations: 56.47 MB / 0.6767 GB, free: 109.4 MB / 0.5138 GB Notification: Performance of preOpt comSubExp (simulation): time 0.02263/1.347, allocations: 30.94 MB / 0.7069 GB, free: 79.64 MB / 0.5138 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.006055/1.353, allocations: 3.959 MB / 0.7107 GB, free: 77.58 MB / 0.5138 GB Notification: Performance of preOpt evalFunc (simulation): time 0.01566/1.369, allocations: 10.77 MB / 0.7213 GB, free: 69.16 MB / 0.5138 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.874e-05/1.369, allocations: 77.81 kB / 0.7213 GB, free: 69.07 MB / 0.5138 GB Notification: Performance of pre-optimization done (n=398): time 4.729e-06/1.369, allocations: 0 / 0.7213 GB, free: 69.07 MB / 0.5138 GB Notification: Performance of matching and sorting (n=423): time 0.04322/1.412, allocations: 21.79 MB / 0.7426 GB, free: 47.38 MB / 0.5138 GB Notification: Performance of inlineWhenForInitialization (initialization): time 6.506e-05/1.412, allocations: 128.7 kB / 0.7427 GB, free: 47.23 MB / 0.5138 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.006788/1.419, allocations: 4.707 MB / 0.7473 GB, free: 42.56 MB / 0.5138 GB Notification: Performance of collectPreVariables (initialization): time 0.0009581/1.42, allocations: 101.7 kB / 0.7474 GB, free: 42.46 MB / 0.5138 GB Notification: Performance of collectInitialEqns (initialization): time 0.002123/1.422, allocations: 4.823 MB / 0.7521 GB, free: 37.72 MB / 0.5138 GB Notification: Performance of collectInitialBindings (initialization): time 0.001362/1.423, allocations: 1.516 MB / 0.7536 GB, free: 36.23 MB / 0.5138 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.001719/1.425, allocations: 1.145 MB / 0.7547 GB, free: 35.07 MB / 0.5138 GB Notification: Performance of setup shared object (initialization): time 4.779e-05/1.425, allocations: 305.1 kB / 0.755 GB, free: 34.77 MB / 0.5138 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.003767/1.429, allocations: 2.916 MB / 0.7579 GB, free: 31.85 MB / 0.5138 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.004663/1.433, allocations: 4.953 MB / 0.7627 GB, free: 25.96 MB / 0.5138 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.009021/1.442, allocations: 8.361 MB / 0.7709 GB, free: 16.66 MB / 0.5138 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.171e-05/1.442, allocations: 19.94 kB / 0.7709 GB, free: 16.64 MB / 0.5138 GB Notification: Performance of matching and sorting (n=764) (initialization): time 0.01678/1.459, allocations: 9.731 MB / 0.7804 GB, free: 6.859 MB / 0.5138 GB Notification: Performance of prepare postOptimizeDAE: time 5.921e-05/1.459, allocations: 36 kB / 0.7804 GB, free: 6.824 MB / 0.5138 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.771e-05/1.459, allocations: 64.41 kB / 0.7805 GB, free: 6.762 MB / 0.5138 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.00428/1.464, allocations: 1.655 MB / 0.7821 GB, free: 5.098 MB / 0.5138 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004934/1.469, allocations: 1.326 MB / 0.7834 GB, free: 3.77 MB / 0.5138 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02485/1.493, allocations: 17.79 MB / 0.8008 GB, free: 1.441 MB / 0.5294 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005392/1.499, allocations: 323.7 kB / 0.8011 GB, free: 1.125 MB / 0.5294 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001207/1.5, allocations: 291.9 kB / 0.8014 GB, free: 0.8398 MB / 0.5294 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 296 * 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 (671): * Single equations (assignments): 667 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 4 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 4 systems {(1,1,100.0%), (7,28,61.2%), (1,1,100.0%), (14,44,39.8%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of prepare postOptimizeDAE: time 0.008322/1.508, allocations: 3.882 MB / 0.8052 GB, free: 12.95 MB / 0.545 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001492/1.51, allocations: 0.5163 MB / 0.8057 GB, free: 12.43 MB / 0.545 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01553/1.525, allocations: 7.737 MB / 0.8132 GB, free: 4.586 MB / 0.545 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.401e-05/1.525, allocations: 48 kB / 0.8133 GB, free: 4.539 MB / 0.545 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 4.654e-05/1.525, allocations: 16 kB / 0.8133 GB, free: 4.523 MB / 0.545 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.694e-05/1.526, allocations: 23.86 kB / 0.8133 GB, free: 4.5 MB / 0.545 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0385/1.564, allocations: 17.47 MB / 0.8304 GB, free: 2.879 MB / 0.5607 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.469e-05/1.564, allocations: 4 kB / 0.8304 GB, free: 2.875 MB / 0.5607 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003806/1.568, allocations: 0.7333 MB / 0.8311 GB, free: 2.141 MB / 0.5607 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.004869/1.573, allocations: 1.546 MB / 0.8326 GB, free: 0.5742 MB / 0.5607 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0009737/1.574, allocations: 108 kB / 0.8327 GB, free: 480 kB / 0.5607 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.2959/1.87, allocations: 21.22 MB / 0.8534 GB, free: 169 MB / 0.5607 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 8.826e-06/1.87, allocations: 9.75 kB / 0.8534 GB, free: 169 MB / 0.5607 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02014/1.89, allocations: 11.46 MB / 0.8646 GB, free: 164 MB / 0.5607 GB Notification: Performance of postOpt removeConstants (simulation): time 0.003197/1.893, allocations: 1.178 MB / 0.8658 GB, free: 163.5 MB / 0.5607 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001391/1.894, allocations: 84.03 kB / 0.8658 GB, free: 163.5 MB / 0.5607 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003475/1.898, allocations: 228.7 kB / 0.8661 GB, free: 163.4 MB / 0.5607 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001021/1.899, allocations: 332.8 kB / 0.8664 GB, free: 163.3 MB / 0.5607 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000358/1.899, allocations: 136.3 kB / 0.8665 GB, free: 163.3 MB / 0.5607 GB Notification: Performance of sorting global known variables: time 0.006033/1.905, allocations: 3.195 MB / 0.8696 GB, free: 162.1 MB / 0.5607 GB Notification: Performance of sort global known variables: time 2.1e-07/1.905, allocations: 0 / 0.8696 GB, free: 162.1 MB / 0.5607 GB Notification: Performance of remove unused functions: time 0.009356/1.915, allocations: 1.863 MB / 0.8715 GB, free: 161.9 MB / 0.5607 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 27 * Number of states: 10 (imcQS.inertiaRotor.w,imcQS.rotorCage.port_p.reference.gamma,loadInertiaQS.phi,imc.inertiaRotor.w,imc.stator.zeroInductor.i0,imc.stator.core.Phi.re,imc.stator.core.Phi.im,imc.stator.stray.Phi.re,imc.stator.stray.Phi.im,loadInertia.phi) * 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 (364): * Single equations (assignments): 357 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 7 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 7 systems {(1,1,100.0%), (14,44,41.3%), (2,12,100.0%), (1,1,100.0%), (1,12,100.0%), (1,5,100.0%), (1,8,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of Backend phase and start with SimCode phase: time 0.01914/1.934, allocations: 12.2 MB / 0.8834 GB, free: 156.3 MB / 0.5607 GB Notification: Performance of simCode: created initialization part: time 0.01307/1.947, allocations: 7.831 MB / 0.891 GB, free: 153.1 MB / 0.5607 GB Notification: Performance of simCode: created event and clocks part: time 1.199e-05/1.947, allocations: 2.656 kB / 0.891 GB, free: 153.1 MB / 0.5607 GB Notification: Performance of simCode: created simulation system equations: time 0.007396/1.954, allocations: 4.407 MB / 0.8953 GB, free: 149.4 MB / 0.5607 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.008082/1.962, allocations: 1.313 MB / 0.8966 GB, free: 148.4 MB / 0.5607 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1024/2.065, allocations: 64.06 MB / 0.9592 GB, free: 84.93 MB / 0.5607 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.008273/2.073, allocations: 6.78 MB / 0.9658 GB, free: 78.11 MB / 0.5607 GB Notification: Performance of simCode: alias equations: time 0.00485/2.078, allocations: 1.865 MB / 0.9676 GB, free: 76.24 MB / 0.5607 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.005869/2.084, allocations: 3.944 MB / 0.9715 GB, free: 72.29 MB / 0.5607 GB Notification: Performance of SimCode: time 1.643e-06/2.084, allocations: 0 / 0.9715 GB, free: 72.29 MB / 0.5607 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.4995/2.583, allocations: 153.6 MB / 1.121 GB, free: 144.8 MB / 0.5763 GB Notification: Performance of buildModelFMU: Generate platform static: time 23.58/26.16, allocations: 16.33 kB / 1.121 GB, free: 144.8 MB / 0.5763 GB " [Timeout remaining time 634] (rm -f Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.InductionMachines.IMC_Initialize.pipe ; mkfifo Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.InductionMachines.IMC_Initialize.pipe ; head -c 1048576 < Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.InductionMachines.IMC_Initialize.pipe >> ../files/Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.InductionMachines.IMC_Initialize.sim & python3 -m fmpy simulate --output-file Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.InductionMachines.IMC_Initialize_res.csv --start-time 0 --stop-time 1.5 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 1e-05 Modelica_4_1_0-beta_om_Modelica_Magnetic_QuasiStatic_FundamentalWave_Examples_BasicMachines_InductionMachines_IMC_Initialize.fmu > Modelica_4.1.0-beta.om_Modelica.Magnetic.QuasiStatic.FundamentalWave.Examples.BasicMachines.InductionMachines.IMC_Initialize.pipe 2>&1) [Timeout 52.5] [Calling os._exit(0), Time elapsed: 29.967969513032585] Failed to read output from testmodel.py, exit status != 0: ['time', 'imc.airGap.V_mrr.im', 'imc.airGap.V_mrr.re', 'imc.airGap.V_msr.im', 'imc.airGap.V_msr.re', 'imc.rotorCage.electroMagneticConverter.singlePhaseElectroMagneticConverter[1].Phi.re', 'imc.rotorCage.electroMagneticConverter.singlePhaseElectroMagneticConverter[2].Phi.im', 'imc.stator.electroMagneticConverter.singlePhaseElectroMagneticConverter[1].Phi.re', 'imc.stator.electroMagneticConverter.singlePhaseElectroMagneticConverter[2].Phi.im', 'imc.stator.port_p.V_m.im', 'imc.stator.port_p.V_m.re', 'imc.stator.zeroInductor.i0', 'imcQS.rotorCage.port_p.reference.gamma', 'loadInertia.phi', 'loadInertia.w', 'loadInertiaQS.phi', 'loadInertiaQS.w'] 26.330635421909392 26.338699941 25.739556053 Calling exit ...