Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PNlib_PNlib.Examples.DisTest.Ttest.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001457/0.001457, allocations: 104.3 kB / 19.76 MB, free: 1.906 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001509/0.001509, allocations: 214.1 kB / 23.06 MB, free: 4.984 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.607/1.607, allocations: 230.7 MB / 256.9 MB, free: 7.781 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PNlib master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PNlib master/package.mo): time 0.08229/0.08229, allocations: 16.95 MB / 330.2 MB, free: 2.133 MB / 254.1 MB " [Timeout remaining time 180] Using package PNlib with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PNlib master/package.mo) Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: translateModel(PNlib.Examples.DisTest.Ttest,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="P1.t|P2.t|P3.t|P4.t|T1.active|T1.fire|T2.active|T2.fire|T3.active|T3.fire|T4.active|T4.fire|time",fileNamePrefix="PNlib_PNlib.Examples.DisTest.Ttest") translateModel(PNlib.Examples.DisTest.Ttest,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="P1.t|P2.t|P3.t|P4.t|T1.active|T1.fire|T2.active|T2.fire|T3.active|T3.fire|T4.active|T4.fire|time",fileNamePrefix="PNlib_PNlib.Examples.DisTest.Ttest") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.65e-05/2.65e-05, allocations: 4.25 kB / 461 MB, free: 1.633 MB / 318.1 MB Notification: Performance of NFInst.instantiate(PNlib.Examples.DisTest.Ttest): time 0.006388/0.006415, allocations: 4.232 MB / 465.2 MB, free: 13.39 MB / 334.1 MB Notification: Performance of NFInst.instExpressions: time 0.01006/0.01647, allocations: 4.117 MB / 469.4 MB, free: 9.262 MB / 334.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.00207/0.01854, allocations: 35.75 kB / 469.4 MB, free: 9.227 MB / 334.1 MB Notification: Performance of NFTyping.typeComponents: time 0.001824/0.02037, allocations: 468.3 kB / 469.9 MB, free: 8.766 MB / 334.1 MB Notification: Performance of NFTyping.typeBindings: time 0.002075/0.02244, allocations: 0.5471 MB / 470.4 MB, free: 8.215 MB / 334.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.006762/0.0292, allocations: 2.28 MB / 472.7 MB, free: 5.934 MB / 334.1 MB Notification: Performance of NFFlatten.flatten: time 0.01106/0.04026, allocations: 6.111 MB / 478.8 MB, free: 15.81 MB / 350.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.001171/0.04143, allocations: 377 kB / 479.2 MB, free: 15.39 MB / 350.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.005272/0.04671, allocations: 2.435 MB / 481.6 MB, free: 12.95 MB / 350.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.004442/0.05115, allocations: 1.984 MB / 483.6 MB, free: 10.96 MB / 350.1 MB Notification: Performance of NFPackage.collectConstants: time 0.002299/0.05345, allocations: 432 kB / 484 MB, free: 10.54 MB / 350.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.003551/0.057, allocations: 1.248 MB / 485.3 MB, free: 9.289 MB / 350.1 MB Notification: Performance of combineBinaries: time 0.008254/0.06525, allocations: 6.111 MB / 491.4 MB, free: 3.125 MB / 350.1 MB Notification: Performance of replaceArrayConstructors: time 0.003623/0.06887, allocations: 3.336 MB / 494.7 MB, free: 15.75 MB / 366.1 MB Notification: Performance of NFVerifyModel.verify: time 0.002336/0.07121, allocations: 396.5 kB / 495.1 MB, free: 15.36 MB / 366.1 MB Notification: Performance of FrontEnd: time 0.0008738/0.07208, allocations: 341.6 kB / 495.4 MB, free: 15.02 MB / 366.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 851 (644) * Number of variables: 851 (764) Notification: Performance of [SIM] Bindings: time 0.02572/0.0978, allocations: 15.62 MB / 0.4991 GB, free: 15.02 MB / 382.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.004554/0.1024, allocations: 2.001 MB / 0.501 GB, free: 12.99 MB / 382.1 MB Notification: Performance of [SIM] Early Inline: time 0.2993/0.4017, allocations: 17.08 MB / 0.5177 GB, free: 40.39 MB / 382.1 MB Notification: Performance of [SIM] Simplify 1: time 0.009444/0.4111, allocations: 3.194 MB / 0.5208 GB, free: 39.97 MB / 382.1 MB Notification: Performance of [SIM] Alias: time 0.0299/0.441, allocations: 14.85 MB / 0.5353 GB, free: 34.79 MB / 382.1 MB Notification: Performance of [SIM] Simplify 2: time 0.006271/0.4473, allocations: 2.933 MB / 0.5382 GB, free: 33.74 MB / 382.1 MB Notification: Performance of [SIM] Remove Stream: time 0.005516/0.4528, allocations: 2.343 MB / 0.5405 GB, free: 32.63 MB / 382.1 MB Notification: Performance of [SIM] Detect States: time 0.009227/0.462, allocations: 4.229 MB / 0.5446 GB, free: 30.01 MB / 382.1 MB Notification: Performance of [SIM] Events: time 0.005056/0.4671, allocations: 3.067 MB / 0.5476 GB, free: 28.52 MB / 382.1 MB Notification: Performance of [SIM] Partitioning: time 0.01548/0.4826, allocations: 7.517 MB / 0.5549 GB, free: 24.26 MB / 382.1 MB Notification: Performance of [SIM] Causalize: time 0.02847/0.511, allocations: 18.67 MB / 0.5732 GB, free: 10.2 MB / 382.1 MB Notification: Performance of [SIM] After Index Reduction Inline: time 0.02262/0.5337, allocations: 15.05 MB / 0.5879 GB, free: 11.27 MB / 398.1 MB Notification: Performance of [INI] Simplify: time 0.02086/0.5545, allocations: 5.724 MB / 0.5935 GB, free: 5.371 MB / 398.1 MB Notification: Performance of [INI] Inline: time 0.04706/0.6016, allocations: 23.4 MB / 0.6163 GB, free: 13.98 MB / 430.1 MB Notification: Performance of [INI] Partitioning: time 0.001257/0.6028, allocations: 254.1 kB / 0.6165 GB, free: 13.69 MB / 430.1 MB Notification: Performance of [INI] Cleanup: time 0.009674/0.6125, allocations: 3.534 MB / 0.62 GB, free: 10.16 MB / 430.1 MB Warning: NBResolveSingularities.balanceInitialization reports an overdetermined initialization! Checking for consistency is not yet supported, following equations had to be removed: [SCAL] (1) $SEV_21 = $PRE.P4.firingSumIn.firingSum > 0 or $PRE.P4.firingSumOut.firingSum > 0 ($RES_EVT_882); [SCAL] (1) $SEV_15 = $PRE.P3.firingSumIn.firingSum > 0 or $PRE.P3.firingSumOut.firingSum > 0 ($RES_EVT_876); Error: Internal error NBResolveSingularities.balanceInitialization failed because following non-fixable variables could not be solved: [DISC] (4) Integer[4] $TEV_9 [DISC] (1) Boolean $SEV_40 [DISC] (1) Boolean $SEV_41 [DISC] (1) Boolean $SEV_42 [DISC] (1) Boolean $SEV_43 [DISC] (1) Boolean $SEV_80 [DISC] (1) Boolean $SEV_81 [DISC] (1) Boolean $SEV_82 [DISC] (1) Boolean $SEV_90 [DISC] (1) Boolean $SEV_91 [DISC] (1) Boolean $SEV_92 [DISC] (1) Boolean $SEV_130 [DISC] (1) Boolean $SEV_131 [DISC] (1) Boolean $SEV_132 [DISC] (1) Boolean $SEV_155 [DISC] (1) Boolean $SEV_156 [DISC] (1) Boolean $SEV_157 [DISC] (1) Boolean $SEV_158 [DISC] (1) protected discrete Real P4.enableIn.benefitLimit [DISC] (1) protected Boolean P4.enableIn.valid [DISC] (1) protected discrete Real P4.enableIn.benefitMax [DISC] (1) protected Integer P4.enableIn.nTAin [DISC] (1) protected Integer P4.enableIn.arcWeightSum [DISC] (1) protected discrete Real P4.enableOut.benefitLimit [DISC] (1) protected Boolean P4.enableOut.valid [DISC] (1) protected discrete Real P4.enableOut.benefitMax [DISC] (1) protected Integer P4.enableOut.Index [DISC] (1) protected Boolean P4.enableOut.endWhile [DISC] (1) protected discrete Real P4.enableOut.sumEnablingProbTAout [DISC] (1) protected Integer P4.enableOut.posTE [DISC] (1) protected Integer P4.enableOut.k [DISC] (1) protected Integer P4.enableOut.nTAout [DISC] (1) protected Integer P4.enableOut.nremTAout [DISC] (1) protected Boolean T4.enabledByInPlaces = PNlib.Functions.OddsAndEnds.allTrue(T4.enableIn) [DISC] (1) Boolean[1] T4.outPlaces.fire = {T4.fire for $f1 in 1:1} [DISC] (1) protected discrete Real P3.enableIn.benefitLimit [DISC] (1) protected Boolean P3.enableIn.valid [DISC] (1) protected discrete Real P3.enableIn.benefitMax [DISC] (1) protected Integer P3.enableIn.Index [DISC] (1) protected Integer P3.enableIn.nTAin [DISC] (1) protected Integer P3.enableIn.arcWeightSum [DISC] (1) protected discrete Real P3.enableOut.benefitLimit [DISC] (1) protected Boolean P3.enableOut.valid [DISC] (1) protected discrete Real P3.enableOut.benefitMax [DISC] (1) protected Integer P3.enableOut.Index [DISC] (1) protected Boolean P3.enableOut.endWhile [DISC] (1) protected discrete Real P3.enableOut.sumEnablingProbTAout [DISC] (1) protected Integer P3.enableOut.posTE [DISC] (1) protected Integer P3.enableOut.k [DISC] (1) protected Integer P3.enableOut.nTAout [DISC] (1) protected Integer P3.enableOut.nremTAout [DISC] (1) Boolean[1] T3.outPlaces.enabledByInPlaces = {T3.enabledByInPlaces for $f1 in 1:1} [DISC] (1) Boolean[1] T3.inPlaces.fire = {T3.fire for $f1 in 1:1} [DISC] (1) Boolean[1] T1.outPlaces.enabledByInPlaces = {T1.enabledByInPlaces for $f1 in 1:1} [DISC] (1) protected discrete Real P2.enableIn.benefitLimit [DISC] (1) protected Boolean P2.enableIn.valid [DISC] (1) protected discrete Real P2.enableIn.benefitMax [DISC] (1) protected Integer P2.enableIn.Index [DISC] (1) protected Integer P2.enableIn.nTAin [DISC] (1) protected Integer P2.enableIn.arcWeightSum [DISC] (1) protected discrete Real P2.enableOut.benefitLimit [DISC] (1) protected Boolean P2.enableOut.valid [DISC] (1) protected discrete Real P2.enableOut.benefitMax [DISC] (1) protected Integer P2.enableOut.Index [DISC] (1) protected Integer P2.enableOut.k [DISC] (1) Boolean[1] P2.inTransition.fire = {P2.fireIn[1]} [DISC] (1) Boolean[1] T2.outPlaces.fire = {T2.fire for $f1 in 1:1} [DISC] (1) protected discrete Real P1.enableIn.benefitLimit [DISC] (1) protected Boolean P1.enableIn.valid [DISC] (1) protected discrete Real P1.enableIn.benefitMax [DISC] (1) protected Integer P1.enableIn.Index [DISC] (1) protected Integer P1.enableIn.k [DISC] (1) protected Integer P1.enableIn.nTAin [DISC] (1) protected Integer P1.enableIn.arcWeightSum [DISC] (1) protected discrete Real P1.enableOut.benefitLimit [DISC] (1) protected Boolean P1.enableOut.valid [DISC] (1) protected discrete Real P1.enableOut.benefitMax [DISC] (1) protected Integer P1.enableOut.Index [DISC] (1) protected Integer P1.enableOut.k Following equations were created by fixing variables: [SCAL] (1) $PRE.T2.firingTime = $START.T2.firingTime ($RES_SRT_1094) [SCAL] (1) $PRE.T2.ani = $START.T2.ani ($RES_SRT_1093) [SCAL] (1) $PRE.T1.fireTime = $START.T1.fireTime ($RES_SRT_1092) [SCAL] (1) $PRE.T3.fireTime = $START.T3.fireTime ($RES_SRT_1091) [SCAL] (1) $PRE.T4.ani = $START.T4.ani ($RES_SRT_1090) [SCAL] (1) $PRE.P1.firingSumIn.firingSum = $START.P1.firingSumIn.firingSum ($RES_SRT_1089) [SCAL] (1) $PRE.P1.firingSumOut.firingSum = $START.P1.firingSumOut.firingSum ($RES_SRT_1088) [SCAL] (1) $PRE.P2.firingSumIn.firingSum = $START.P2.firingSumIn.firingSum ($RES_SRT_1087) [SCAL] (1) $PRE.P2.firingSumOut.firingSum = $START.P2.firingSumOut.firingSum ($RES_SRT_1086) [SCAL] (1) $PRE.P3.firingSumIn.firingSum = $START.P3.firingSumIn.firingSum ($RES_SRT_1085) [SCAL] (1) $PRE.P3.firingSumOut.firingSum = $START.P3.firingSumOut.firingSum ($RES_SRT_1084) [SCAL] (1) $PRE.P4.firingSumIn.firingSum = $START.P4.firingSumIn.firingSum ($RES_SRT_1083) [SCAL] (1) $PRE.P4.firingSumOut.firingSum = $START.P4.firingSumOut.firingSum ($RES_SRT_1082) [ARRY] (4) $PRE.P1.enableOut.state128 = $START.P1.enableOut.state128 ($RES_SRT_1081) [ARRY] (4) $PRE.P1.enableIn.state128 = $START.P1.enableIn.state128 ($RES_SRT_1080) [ARRY] (4) $PRE.P2.enableOut.state128 = $START.P2.enableOut.state128 ($RES_SRT_1079) [ARRY] (4) $PRE.P2.enableIn.state128 = $START.P2.enableIn.state128 ($RES_SRT_1078) [ARRY] (4) $PRE.P3.enableOut.state128 = $START.P3.enableOut.state128 ($RES_SRT_1077) [ARRY] (4) $PRE.P3.enableIn.state128 = $START.P3.enableIn.state128 ($RES_SRT_1076) [ARRY] (4) $PRE.P4.enableOut.state128 = $START.P4.enableOut.state128 ($RES_SRT_1075) [ARRY] (4) $PRE.P4.enableIn.state128 = $START.P4.enableIn.state128 ($RES_SRT_1074) [SCAL] (1) $PRE.T4.fireTime = $START.T4.fireTime ($RES_SRT_1073) [SCAL] (1) $PRE.T3.ani = $START.T3.ani ($RES_SRT_1072) [SCAL] (1) $PRE.T1.ani = $START.T1.ani ($RES_SRT_1071) [SCAL] (1) $PRE.T2.fireTime = $START.T2.fireTime ($RES_SRT_1070) Use -d=bltdump for more verbose debug output. Error: Internal error NBInitialization.main failed to apply modules! " [Timeout remaining time 659] [Calling sys.exit(0), Time elapsed: 3.451502754993271] Failed to read output from testmodel.py, exit status != 0: 0.6597137509961613 0.676511772 0.6003376069999999 Calling exit ...