Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_DeviceDrivers_Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM.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 4.0.0+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/package.mo", uses=false) Using package Modelica_DeviceDrivers with version 2.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/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 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: translateModel(Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Modelica_DeviceDrivers_Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM") translateModel(Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Modelica_DeviceDrivers_Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001094/0.001094, allocations: 119.4 kB / 17.14 MB, free: 5.914 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.001389/0.001389, allocations: 186 kB / 18.07 MB, free: 4.996 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.311/1.311, allocations: 222.9 MB / 241.8 MB, free: 15.07 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/package.mo): time 0.05799/0.05799, allocations: 12.05 MB / 304 MB, free: 3.082 MB / 238.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001223/0.001223, allocations: 63.91 kB / 420.8 MB, free: 17.2 MB / 302.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.08459/0.08582, allocations: 52.32 MB / 473.1 MB, free: 12.84 MB / 350.1 MB Notification: Performance of NFInst.instantiate(Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM): time 0.004575/0.09043, allocations: 2.923 MB / 476 MB, free: 9.898 MB / 350.1 MB Notification: Performance of NFInst.instExpressions: time 0.001719/0.09218, allocations: 0.8912 MB / 476.9 MB, free: 9.004 MB / 350.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.0001424/0.09234, allocations: 7.938 kB / 476.9 MB, free: 8.996 MB / 350.1 MB Notification: Performance of NFTyping.typeComponents: time 0.000281/0.09264, allocations: 87.19 kB / 477 MB, free: 8.91 MB / 350.1 MB Notification: Performance of NFTyping.typeBindings: time 0.0001937/0.09284, allocations: 59.47 kB / 477 MB, free: 8.852 MB / 350.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/Blocks/Packaging/SerialPackager.mo:130:7-137:16:writable] Warning: Pure function 'Modelica_DeviceDrivers.Blocks.Packaging.SerialPackager.Internal.DummyFunctions.clear' contains a call to impure function 'Modelica_DeviceDrivers.Packaging.SerialPackager_.clear'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/Blocks/Packaging/SerialPackager.mo:30:7-39:18:writable] Warning: Pure function 'Modelica_DeviceDrivers.Blocks.Packaging.SerialPackager.Internal.DummyFunctions.addReal' contains a call to impure function 'Modelica_DeviceDrivers.Packaging.SerialPackager_.addReal'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/Blocks/Communication.mo:1272:7-1282:20:writable] Warning: Pure function 'Modelica_DeviceDrivers.Blocks.Communication.Internal.DummyFunctions.sendToLCM' contains a call to impure function 'Modelica_DeviceDrivers.Communication.LCM_.sendTo'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/Blocks/Packaging/SerialPackager.mo:63:7-72:21:writable] Warning: Pure function 'Modelica_DeviceDrivers.Blocks.Packaging.SerialPackager.Internal.DummyFunctions.addInteger' contains a call to impure function 'Modelica_DeviceDrivers.Packaging.SerialPackager_.addInteger'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/Blocks/Communication.mo:1262:7-1270:18:writable] Warning: Pure function 'Modelica_DeviceDrivers.Blocks.Communication.Internal.DummyFunctions.readLCM' contains a call to impure function 'Modelica_DeviceDrivers.Communication.LCM_.read'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/Blocks/Packaging/SerialPackager.mo:74:7-84:18:writable] Warning: Pure function 'Modelica_DeviceDrivers.Blocks.Packaging.SerialPackager.Internal.DummyFunctions.getReal' contains a call to impure function 'Modelica_DeviceDrivers.Packaging.SerialPackager_.getReal'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/Blocks/Packaging/SerialPackager.mo:107:7-117:21:writable] Warning: Pure function 'Modelica_DeviceDrivers.Blocks.Packaging.SerialPackager.Internal.DummyFunctions.getInteger' contains a call to impure function 'Modelica_DeviceDrivers.Packaging.SerialPackager_.getInteger'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/Blocks/Packaging/SerialPackager.mo:41:7-50:25:writable] Warning: Pure function 'Modelica_DeviceDrivers.Blocks.Packaging.SerialPackager.Internal.DummyFunctions.addRealAsFloat' contains a call to impure function 'Modelica_DeviceDrivers.Packaging.SerialPackager_.addRealAsFloat'. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica_DeviceDrivers 2.1.1-master/Blocks/Packaging/SerialPackager.mo:86:7-96:27:writable] Warning: Pure function 'Modelica_DeviceDrivers.Blocks.Packaging.SerialPackager.Internal.DummyFunctions.getRealFromFloat' contains a call to impure function 'Modelica_DeviceDrivers.Packaging.SerialPackager_.getRealFromFloat'. Notification: Performance of NFTyping.typeClassSections: time 0.0006709/0.09352, allocations: 279.2 kB / 477.3 MB, free: 8.578 MB / 350.1 MB Notification: Performance of NFFlatten.flatten: time 0.0004377/0.09397, allocations: 407 kB / 477.7 MB, free: 8.18 MB / 350.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0003431/0.09433, allocations: 247 kB / 477.9 MB, free: 7.934 MB / 350.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0002001/0.09453, allocations: 203.2 kB / 478.1 MB, free: 7.734 MB / 350.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0002772/0.09482, allocations: 243 kB / 478.4 MB, free: 7.496 MB / 350.1 MB Notification: Performance of NFPackage.collectConstants: time 7.277e-05/0.0949, allocations: 48 kB / 478.4 MB, free: 7.449 MB / 350.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0002785/0.09519, allocations: 187.8 kB / 478.6 MB, free: 7.266 MB / 350.1 MB Notification: Performance of NFScalarize.scalarize: time 0.000152/0.09535, allocations: 151.6 kB / 478.8 MB, free: 7.117 MB / 350.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0001849/0.09554, allocations: 230.7 kB / 479 MB, free: 6.891 MB / 350.1 MB Notification: Performance of NFConvertDAE.convert: time 0.0007033/0.09625, allocations: 0.6769 MB / 479.7 MB, free: 6.211 MB / 350.1 MB Notification: Performance of FrontEnd - DAE generated: time 4.088e-06/0.09626, allocations: 0 / 479.7 MB, free: 6.211 MB / 350.1 MB Notification: Performance of FrontEnd: time 1.353e-06/0.09627, allocations: 0 / 479.7 MB, free: 6.211 MB / 350.1 MB Notification: Performance of Transformations before backend: time 1.036e-05/0.09628, allocations: 0 / 479.7 MB, free: 6.211 MB / 350.1 MB Warning: Alias equations of external objects are not Modelica compliant as in: getFloat.pkgOut[1].pkg = getFloat.pkgIn.pkg addFloat.pkgOut[1].pkg = addFloat.pkgIn.pkg getReal.pkgOut[1].pkg = getReal.pkgIn.pkg addInteger.pkgOut[1].pkg = addInteger.pkgIn.pkg addReal.pkgOut[1].pkg = addReal.pkgIn.pkg getInteger.pkgIn.pkg = getFloat.pkgOut[1].pkg getReal.pkgOut[1].pkg = getFloat.pkgIn.pkg lcmSend.pkgIn.pkg = addInteger.pkgOut[1].pkg addFloat.pkgOut[1].pkg = addInteger.pkgIn.pkg addReal.pkgOut[1].pkg = addFloat.pkgIn.pkg lcmReceive.pkgOut.pkg = getReal.pkgIn.pkg packager.pkgOut.pkg = addReal.pkgIn.pkg Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 105 * Number of variables: 105 Notification: Performance of Generate backend data structure: time 0.001532/0.09782, allocations: 1.176 MB / 480.8 MB, free: 4.934 MB / 350.1 MB Notification: Performance of prepare preOptimizeDAE: time 3.489e-05/0.09786, allocations: 8.031 kB / 480.8 MB, free: 4.926 MB / 350.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0001091/0.09798, allocations: 60.53 kB / 480.9 MB, free: 4.867 MB / 350.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.0003424/0.09833, allocations: 327.6 kB / 481.2 MB, free: 4.508 MB / 350.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.87e-05/0.09838, allocations: 29.38 kB / 481.3 MB, free: 4.48 MB / 350.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 5.989e-05/0.09844, allocations: 44.36 kB / 481.3 MB, free: 4.438 MB / 350.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0007413/0.09919, allocations: 476.1 kB / 481.8 MB, free: 3.953 MB / 350.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 1.339e-05/0.09921, allocations: 4.125 kB / 481.8 MB, free: 3.949 MB / 350.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.079e-05/0.09926, allocations: 23.92 kB / 481.8 MB, free: 3.926 MB / 350.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.148e-05/0.09928, allocations: 12 kB / 481.8 MB, free: 3.914 MB / 350.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.000459/0.09974, allocations: 263.6 kB / 482.1 MB, free: 3.656 MB / 350.1 MB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.001514/0.1013, allocations: 1.363 MB / 483.4 MB, free: 2.223 MB / 350.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.0005315/0.1018, allocations: 302.3 kB / 483.7 MB, free: 1.891 MB / 350.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.000233/0.1021, allocations: 155.4 kB / 483.9 MB, free: 1.727 MB / 350.1 MB Notification: Performance of preOpt evalFunc (simulation): time 3.077e-05/0.1021, allocations: 7.984 kB / 483.9 MB, free: 1.719 MB / 350.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0003643/0.1025, allocations: 256.7 kB / 484.1 MB, free: 1.438 MB / 350.1 MB Notification: Performance of pre-optimization done (n=40): time 2.245e-06/0.1025, allocations: 0 / 484.1 MB, free: 1.438 MB / 350.1 MB Notification: Performance of matching and sorting (n=40): time 0.001028/0.1035, allocations: 0.5815 MB / 484.7 MB, free: 0.8516 MB / 350.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 7.653e-05/0.1036, allocations: 152.5 kB / 484.9 MB, free: 0.6719 MB / 350.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0002481/0.1038, allocations: 260.9 kB / 485.1 MB, free: 420 kB / 350.1 MB Notification: Performance of collectPreVariables (initialization): time 3.969e-05/0.1039, allocations: 49.69 kB / 485.2 MB, free: 364 kB / 350.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.0001269/0.104, allocations: 212.7 kB / 485.4 MB, free: 148 kB / 350.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.0001241/0.1042, allocations: 111.2 kB / 485.5 MB, free: 36 kB / 350.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001592/0.1043, allocations: 114.2 kB / 485.6 MB, free: 15.92 MB / 366.1 MB Notification: Performance of setup shared object (initialization): time 0.0001226/0.1045, allocations: 350.7 kB / 485.9 MB, free: 15.57 MB / 366.1 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002155/0.1047, allocations: 121 kB / 486.1 MB, free: 15.45 MB / 366.1 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0003237/0.105, allocations: 310.4 kB / 486.4 MB, free: 15.05 MB / 366.1 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.0005831/0.1056, allocations: 488.6 kB / 486.8 MB, free: 14.49 MB / 366.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.182e-06/0.1056, allocations: 0 / 486.8 MB, free: 14.49 MB / 366.1 MB Notification: Performance of matching and sorting (n=62) (initialization): time 0.0007797/0.1064, allocations: 497.2 kB / 487.3 MB, free: 14 MB / 366.1 MB Notification: Performance of prepare postOptimizeDAE: time 1.816e-05/0.1064, allocations: 10.03 kB / 487.3 MB, free: 13.99 MB / 366.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.452e-05/0.1065, allocations: 12.06 kB / 487.3 MB, free: 13.98 MB / 366.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 2.087e-05/0.1065, allocations: 8 kB / 487.3 MB, free: 13.97 MB / 366.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000249/0.1067, allocations: 83.77 kB / 487.4 MB, free: 13.89 MB / 366.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.693e-05/0.1068, allocations: 8 kB / 487.4 MB, free: 13.88 MB / 366.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.000179/0.1069, allocations: 39.73 kB / 487.5 MB, free: 13.84 MB / 366.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.786e-05/0.107, allocations: 27.98 kB / 487.5 MB, free: 13.81 MB / 366.1 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 29 * Number of states: 0 () * Number of discrete variables: 54 (addFloat.pkgOut[1].dummy,$PRE.addFloat.pkgOut[1].dummy,addInteger.pkgOut[1].dummy,$PRE.addInteger.pkgOut[1].dummy,lcmSend.dummy,$PRE.lcmSend.dummy,addReal.pkgOut[1].dummy,$PRE.addReal.pkgOut[1].dummy,packager.pkgOut.dummy,$PRE.packager.pkgOut.dummy,addFloat.pkgOut[1].backwardTrigger,addFloat.pkgOut[1].trigger,$whenCondition2,addInteger.u[1],getFloat.dummy,$PRE.getFloat.dummy,getFloat.y[2],$PRE.getFloat.y[2],getFloat.y[1],$PRE.getFloat.y[1],getFloat.pkgOut[1].dummy,$PRE.getFloat.pkgOut[1].dummy,getInteger.dummy,$PRE.getInteger.dummy,getInteger.y[1],$PRE.getInteger.y[1],getReal.dummy,$PRE.getReal.dummy,getReal.y[3],$PRE.getReal.y[3],getReal.y[2],$PRE.getReal.y[2],getReal.y[1],$PRE.getReal.y[1],getReal.pkgOut[1].dummy,$PRE.getReal.pkgOut[1].dummy,lcmReceive.pkgOut.dummy,$PRE.lcmReceive.pkgOut.dummy,getFloat.pkgOut[1].trigger,$whenCondition1,getInteger.pkgIn.userPkgBitSize,getInteger.pkgIn.backwardTrigger,getFloat.pkgIn.autoPkgBitSize,getInteger.pkgIn.autoPkgBitSize,getReal.pkgIn.autoPkgBitSize,lcmReceive.bufferSize,addFloat.pkgIn.autoPkgBitSize,addInteger.pkgIn.autoPkgBitSize,lcmSend.pkgIn.autoPkgBitSize,lcmSend.pkgIn.userPkgBitSize,addReal.pkgIn.autoPkgBitSize,packager.bufferSize,packager.backwardPropagatedBufferSize,lcmSend.bufferSize) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (62): * Single equations (assignments): 62 * 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.0002568/0.1073, allocations: 238.7 kB / 487.7 MB, free: 13.57 MB / 366.1 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 6.345e-05/0.1073, allocations: 31.81 kB / 487.8 MB, free: 13.54 MB / 366.1 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0004068/0.1077, allocations: 235.4 kB / 488 MB, free: 13.3 MB / 366.1 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.845e-06/0.1078, allocations: 4 kB / 488 MB, free: 13.3 MB / 366.1 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.703e-06/0.1078, allocations: 0 / 488 MB, free: 13.3 MB / 366.1 MB Notification: Performance of postOpt removeConstants (simulation): time 6.603e-05/0.1078, allocations: 108.9 kB / 488.1 MB, free: 13.17 MB / 366.1 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 4.264e-05/0.1079, allocations: 8 kB / 488.1 MB, free: 13.16 MB / 366.1 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 9.75e-05/0.108, allocations: 15.92 kB / 488.1 MB, free: 13.15 MB / 366.1 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 5.193e-05/0.108, allocations: 19.97 kB / 488.2 MB, free: 13.13 MB / 366.1 MB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.000919/0.109, allocations: 0.7753 MB / 488.9 MB, free: 12.35 MB / 366.1 MB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.000918/0.1099, allocations: 0.8826 MB / 489.8 MB, free: 11.45 MB / 366.1 MB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.00025/0.1102, allocations: 156.4 kB / 490 MB, free: 11.3 MB / 366.1 MB Notification: Performance of sorting global known variables: time 0.0001397/0.1103, allocations: 156.5 kB / 490.1 MB, free: 11.15 MB / 366.1 MB Notification: Performance of Backend: time 6.91e-07/0.1103, allocations: 0 / 490.1 MB, free: 11.15 MB / 366.1 MB Notification: Performance of simCode: created initialization part: time 0.001618/0.1119, allocations: 0.5388 MB / 490.7 MB, free: 10.68 MB / 366.1 MB Notification: Performance of SimCode: time 0.001359/0.1133, allocations: 1.087 MB / 491.7 MB, free: 9.539 MB / 366.1 MB Notification: Performance of Templates: time 0.01045/0.1238, allocations: 5.501 MB / 497.2 MB, free: 4.078 MB / 366.1 MB make -j1 -f Modelica_DeviceDrivers_Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM.makefile (rm -f Modelica_DeviceDrivers_Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM.pipe ; mkfifo Modelica_DeviceDrivers_Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM.pipe ; head -c 1048576 < Modelica_DeviceDrivers_Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM.pipe >> ../files/Modelica_DeviceDrivers_Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM.sim & ./Modelica_DeviceDrivers_Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM -abortSlowSimulation -alarm=480 -lv LOG_STATS > Modelica_DeviceDrivers_Modelica_DeviceDrivers.Blocks.Examples.TestSerialPackager_LCM.pipe 2>&1)