Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr OpenIPSL_dev_OpenIPSL.Tests.Machines.PSAT.Order6test2.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/Modelica 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/OpenIPSL 3.1.0-master/package.mo", uses=false) Using package OpenIPSL with version 3.1.0-dev (/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/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 Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 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(OpenIPSL.Tests.Machines.PSAT.Order6test2,fileNamePrefix="OpenIPSL_dev_OpenIPSL_Tests_Machines_PSAT_Order6test2",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(OpenIPSL.Tests.Machines.PSAT.Order6test2,fileNamePrefix="OpenIPSL_dev_OpenIPSL_Tests_Machines_PSAT_Order6test2",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.01016/0.01016, allocations: 104.7 kB / 15.74 MB, free: 6.484 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.313/1.313, allocations: 222.9 MB / 239.4 MB, free: 4.551 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001416/0.001416, allocations: 184.5 kB / 289.7 MB, free: 2.273 MB / 238.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/OpenIPSL 3.1.0-master/package.mo): time 0.4985/0.4985, allocations: 91.9 MB / 431.8 MB, free: 9.176 MB / 302.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001363/0.001363, allocations: 81.66 kB / 0.5723 GB, free: 33.93 MB / 430.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1148/0.1162, allocations: 71.27 MB / 0.6419 GB, free: 4.098 MB / 446.1 MB Notification: Performance of NFInst.instantiate(OpenIPSL.Tests.Machines.PSAT.Order6test2): time 0.005776/0.122, allocations: 5.968 MB / 0.6477 GB, free: 14.1 MB / 462.1 MB Notification: Performance of NFInst.instExpressions: time 0.003252/0.1253, allocations: 1.79 MB / 0.6494 GB, free: 12.3 MB / 462.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0005293/0.1258, allocations: 11.94 kB / 0.6494 GB, free: 12.29 MB / 462.1 MB Notification: Performance of NFTyping.typeComponents: time 0.000463/0.1263, allocations: 206.2 kB / 0.6496 GB, free: 12.09 MB / 462.1 MB Notification: Performance of NFTyping.typeBindings: time 0.001574/0.1279, allocations: 0.7681 MB / 0.6504 GB, free: 11.32 MB / 462.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.001112/0.129, allocations: 0.5684 MB / 0.6509 GB, free: 10.75 MB / 462.1 MB Notification: Performance of NFFlatten.flatten: time 0.001252/0.1303, allocations: 1.351 MB / 0.6523 GB, free: 9.398 MB / 462.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0003819/0.1307, allocations: 282 kB / 0.6525 GB, free: 9.113 MB / 462.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0005901/0.1313, allocations: 0.5602 MB / 0.6531 GB, free: 8.551 MB / 462.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0006518/0.132, allocations: 0.6922 MB / 0.6538 GB, free: 7.855 MB / 462.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0001244/0.1321, allocations: 100 kB / 0.6539 GB, free: 7.758 MB / 462.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.000376/0.1325, allocations: 227.9 kB / 0.6541 GB, free: 7.535 MB / 462.1 MB Notification: Performance of NFScalarize.scalarize: time 0.0001872/0.1327, allocations: 266.8 kB / 0.6543 GB, free: 7.273 MB / 462.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0004094/0.1331, allocations: 0.567 MB / 0.6549 GB, free: 6.703 MB / 462.1 MB Notification: Performance of NFConvertDAE.convert: time 0.001263/0.1344, allocations: 1.437 MB / 0.6563 GB, free: 5.262 MB / 462.1 MB Notification: Performance of FrontEnd - DAE generated: time 5.971e-06/0.1344, allocations: 0 / 0.6563 GB, free: 5.262 MB / 462.1 MB Notification: Performance of FrontEnd: time 2.565e-06/0.1344, allocations: 0 / 0.6563 GB, free: 5.262 MB / 462.1 MB Notification: Performance of Transformations before backend: time 2.034e-05/0.1344, allocations: 0 / 0.6563 GB, free: 5.262 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: 170 * Number of variables: 170 Notification: Performance of Generate backend data structure: time 0.007572/0.142, allocations: 2.442 MB / 0.6587 GB, free: 2.766 MB / 462.1 MB Notification: Performance of prepare preOptimizeDAE: time 4.321e-05/0.142, allocations: 8.031 kB / 0.6587 GB, free: 2.758 MB / 462.1 MB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001286/0.1422, allocations: 118.5 kB / 0.6588 GB, free: 2.633 MB / 462.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004611/0.1468, allocations: 0.7634 MB / 0.6595 GB, free: 1.867 MB / 462.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.001215/0.148, allocations: 0.7517 MB / 0.6603 GB, free: 1.074 MB / 462.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002589/0.1483, allocations: 248.2 kB / 0.6605 GB, free: 0.793 MB / 462.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001352/0.1484, allocations: 71.91 kB / 0.6606 GB, free: 0.7227 MB / 462.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.001851/0.1503, allocations: 0.9872 MB / 0.6615 GB, free: 15.73 MB / 478.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 1.696e-05/0.1503, allocations: 0 / 0.6615 GB, free: 15.73 MB / 478.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.863e-05/0.1504, allocations: 28 kB / 0.6616 GB, free: 15.7 MB / 478.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.604e-05/0.1504, allocations: 16 kB / 0.6616 GB, free: 15.68 MB / 478.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001953/0.1524, allocations: 0.9916 MB / 0.6625 GB, free: 14.7 MB / 478.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.005034/0.1574, allocations: 3.262 MB / 0.6657 GB, free: 11.28 MB / 478.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.001905/0.1594, allocations: 1.348 MB / 0.667 GB, free: 9.805 MB / 478.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.001271/0.1607, allocations: 0.7188 MB / 0.6677 GB, free: 9.082 MB / 478.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0001068/0.1608, allocations: 16.98 kB / 0.6678 GB, free: 9.066 MB / 478.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.528e-05/0.1608, allocations: 43.55 kB / 0.6678 GB, free: 9.016 MB / 478.1 MB Notification: Performance of pre-optimization done (n=85): time 9.548e-06/0.1608, allocations: 0 / 0.6678 GB, free: 9.016 MB / 478.1 MB Notification: Performance of matching and sorting (n=85): time 0.02242/0.1832, allocations: 6.563 MB / 0.6742 GB, free: 2.418 MB / 478.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 5.452e-05/0.1833, allocations: 72.28 kB / 0.6743 GB, free: 2.336 MB / 478.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001258/0.1846, allocations: 0.8429 MB / 0.6751 GB, free: 1.469 MB / 478.1 MB Notification: Performance of collectPreVariables (initialization): time 0.0001512/0.1848, allocations: 41.7 kB / 0.6751 GB, free: 1.422 MB / 478.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.0003357/0.1851, allocations: 440.5 kB / 0.6756 GB, free: 0.9844 MB / 478.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.0003458/0.1855, allocations: 315.5 kB / 0.6759 GB, free: 0.6719 MB / 478.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004488/0.1859, allocations: 198.8 kB / 0.6761 GB, free: 480 kB / 478.1 MB Notification: Performance of setup shared object (initialization): time 0.0001211/0.1861, allocations: 349.9 kB / 0.6764 GB, free: 124 kB / 478.1 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001393/0.1875, allocations: 0.6898 MB / 0.6771 GB, free: 15.43 MB / 494.1 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001646/0.1891, allocations: 0.8267 MB / 0.6779 GB, free: 14.57 MB / 494.1 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.002944/0.1921, allocations: 1.482 MB / 0.6793 GB, free: 13.06 MB / 494.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.024e-06/0.1921, allocations: 0 / 0.6793 GB, free: 13.06 MB / 494.1 MB Notification: Performance of matching and sorting (n=143) (initialization): time 0.01261/0.2047, allocations: 4.277 MB / 0.6835 GB, free: 8.766 MB / 494.1 MB Notification: Performance of prepare postOptimizeDAE: time 2.579e-05/0.2048, allocations: 5.094 kB / 0.6835 GB, free: 8.762 MB / 494.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.401e-05/0.2048, allocations: 4 kB / 0.6835 GB, free: 8.758 MB / 494.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.006209/0.211, allocations: 1.85 MB / 0.6853 GB, free: 6.906 MB / 494.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009032/0.2119, allocations: 183.7 kB / 0.6855 GB, free: 6.727 MB / 494.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02051/0.2325, allocations: 9.461 MB / 0.6947 GB, free: 13.11 MB / 0.4981 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001562/0.2341, allocations: 151 kB / 0.6949 GB, free: 12.96 MB / 0.4981 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002433/0.2343, allocations: 39.98 kB / 0.6949 GB, free: 12.93 MB / 0.4981 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 10 * 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 (106): * Single equations (assignments): 105 * 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 {(24,14)} Notification: Performance of prepare postOptimizeDAE: time 0.0006327/0.235, allocations: 226.2 kB / 0.6951 GB, free: 12.7 MB / 0.4981 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000338/0.2353, allocations: 114.6 kB / 0.6952 GB, free: 12.58 MB / 0.4981 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01164/0.247, allocations: 3.876 MB / 0.699 GB, free: 8.688 MB / 0.4981 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.23e-05/0.247, allocations: 11.94 kB / 0.699 GB, free: 8.676 MB / 0.4981 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 3.487e-06/0.247, allocations: 0 / 0.699 GB, free: 8.676 MB / 0.4981 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.208e-05/0.247, allocations: 3.984 kB / 0.699 GB, free: 8.672 MB / 0.4981 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.013/0.26, allocations: 5.435 MB / 0.7043 GB, free: 3.098 MB / 0.4981 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.008e-05/0.2601, allocations: 0 / 0.7043 GB, free: 3.098 MB / 0.4981 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00057/0.2607, allocations: 99.81 kB / 0.7044 GB, free: 3 MB / 0.4981 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.005277/0.2659, allocations: 1.745 MB / 0.7061 GB, free: 1.25 MB / 0.4981 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001284/0.2661, allocations: 16 kB / 0.7062 GB, free: 1.234 MB / 0.4981 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01669/0.2828, allocations: 8.044 MB / 0.714 GB, free: 9.043 MB / 0.5137 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.447e-06/0.2828, allocations: 3.938 kB / 0.714 GB, free: 9.039 MB / 0.5137 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01345/0.2963, allocations: 4.763 MB / 0.7187 GB, free: 4.258 MB / 0.5137 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0004607/0.2968, allocations: 199.6 kB / 0.7189 GB, free: 4.043 MB / 0.5137 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002881/0.2971, allocations: 19.94 kB / 0.7189 GB, free: 4.023 MB / 0.5137 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001089/0.2982, allocations: 91.89 kB / 0.719 GB, free: 3.934 MB / 0.5137 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006502/0.2989, allocations: 200.7 kB / 0.7192 GB, free: 3.734 MB / 0.5137 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 9.123e-05/0.299, allocations: 24 kB / 0.7192 GB, free: 3.711 MB / 0.5137 GB Notification: Performance of sorting global known variables: time 0.0008037/0.2998, allocations: 0.5741 MB / 0.7197 GB, free: 3.125 MB / 0.5137 GB Notification: Performance of sort global known variables: time 2.01e-07/0.2998, allocations: 0 / 0.7197 GB, free: 3.125 MB / 0.5137 GB Notification: Performance of remove unused functions: time 0.001388/0.3012, allocations: 431.5 kB / 0.7202 GB, free: 2.703 MB / 0.5137 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 1 * Number of states: 6 (order6Type2_1.delta,order6Type2_1.w,order6Type2_1.e1q,order6Type2_1.e1d,order6Type2_1.e2q,order6Type2_1.e2d) * 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 (52): * Single equations (assignments): 51 * 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 {(26,10)} Notification: Performance of Backend phase and start with SimCode phase: time 0.01338/0.3146, allocations: 5.349 MB / 0.7254 GB, free: 13.32 MB / 0.5294 GB Notification: Performance of simCode: created initialization part: time 0.006275/0.3209, allocations: 2.411 MB / 0.7277 GB, free: 10.9 MB / 0.5294 GB Notification: Performance of simCode: created event and clocks part: time 5.61e-06/0.3209, allocations: 8.062 kB / 0.7277 GB, free: 10.89 MB / 0.5294 GB Notification: Performance of simCode: created simulation system equations: time 0.00419/0.3251, allocations: 1.525 MB / 0.7292 GB, free: 9.352 MB / 0.5294 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0009405/0.3261, allocations: 87.31 kB / 0.7293 GB, free: 9.266 MB / 0.5294 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03494/0.361, allocations: 14.9 MB / 0.7439 GB, free: 10.18 MB / 0.545 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000615/0.3617, allocations: 1.041 MB / 0.7449 GB, free: 9.109 MB / 0.545 GB Notification: Performance of simCode: alias equations: time 0.0003513/0.3621, allocations: 86.44 kB / 0.745 GB, free: 9.02 MB / 0.545 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.00052/0.3626, allocations: 387.3 kB / 0.7453 GB, free: 8.641 MB / 0.545 GB Notification: Performance of SimCode: time 2.425e-06/0.3626, allocations: 0 / 0.7453 GB, free: 8.641 MB / 0.545 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.3236/0.6862, allocations: 32.53 MB / 0.7771 GB, free: 119.8 MB / 0.5606 GB Notification: Performance of buildModelFMU: Generate platform static: time 14.6/15.29, allocations: 3.438 kB / 0.7771 GB, free: 119.8 MB / 0.5606 GB (rm -f OpenIPSL_dev_OpenIPSL.Tests.Machines.PSAT.Order6test2.pipe ; mkfifo OpenIPSL_dev_OpenIPSL.Tests.Machines.PSAT.Order6test2.pipe ; head -c 1048576 < OpenIPSL_dev_OpenIPSL.Tests.Machines.PSAT.Order6test2.pipe >> ../files/OpenIPSL_dev_OpenIPSL.Tests.Machines.PSAT.Order6test2.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --tempDir=temp_OpenIPSL_dev_OpenIPSL_Tests_Machines_PSAT_Order6test2_fmu --startTime=0 --stopTime=20 --timeout=50 --tolerance=1e-06 OpenIPSL_dev_OpenIPSL_Tests_Machines_PSAT_Order6test2.fmu > OpenIPSL_dev_OpenIPSL.Tests.Machines.PSAT.Order6test2.pipe 2>&1)