Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_trunk_Modelica.ComplexBlocks.Examples.ShowTransferFunction.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.00134/0.00134, allocations: 99.64 kB / 21.25 MB, free: 424 kB / 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.001471/0.001471, allocations: 215.3 kB / 24.55 MB, free: 3.719 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.605/1.605, allocations: 230.5 MB / 258.2 MB, free: 7.75 MB / 206.1 MB " [Timeout remaining time 178] Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/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: translateModel(Modelica.ComplexBlocks.Examples.ShowTransferFunction,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="time|logFrequencySweep.y|const.y.re|const.y.im|transferFunction.y.re|transferFunction.y.im",fileNamePrefix="Modelica_trunk_Modelica.ComplexBlocks.Examples.ShowTransferFunction") translateModel(Modelica.ComplexBlocks.Examples.ShowTransferFunction,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="time|logFrequencySweep.y|const.y.re|const.y.im|transferFunction.y.re|transferFunction.y.im",fileNamePrefix="Modelica_trunk_Modelica.ComplexBlocks.Examples.ShowTransferFunction") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 3.258e-05/3.258e-05, allocations: 2.281 kB / 379 MB, free: 2.453 MB / 302.1 MB Notification: Performance of NFInst.instantiate(Modelica.ComplexBlocks.Examples.ShowTransferFunction): time 0.003642/0.003674, allocations: 1.683 MB / 380.7 MB, free: 0.7578 MB / 302.1 MB Notification: Performance of NFInst.instExpressions: time 0.001566/0.005241, allocations: 0.7204 MB / 381.4 MB, free: 32 kB / 302.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 6.013e-05/0.005301, allocations: 4 kB / 381.4 MB, free: 28 kB / 302.1 MB Notification: Performance of NFTyping.typeComponents: time 0.2819/0.2872, allocations: 43.73 kB / 381.5 MB, free: 13.02 MB / 302.1 MB Notification: Performance of NFTyping.typeBindings: time 0.0004587/0.2877, allocations: 40.72 kB / 381.5 MB, free: 13.02 MB / 302.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.001565/0.2892, allocations: 467.6 kB / 382 MB, free: 13.02 MB / 302.1 MB Notification: Performance of NFFlatten.flatten: time 0.0004571/0.2897, allocations: 155.5 kB / 382.1 MB, free: 13.01 MB / 302.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0001605/0.2898, allocations: 18.05 kB / 382.1 MB, free: 13.01 MB / 302.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0001599/0.29, allocations: 65.3 kB / 382.2 MB, free: 13 MB / 302.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0003074/0.2903, allocations: 76.64 kB / 382.3 MB, free: 12.98 MB / 302.1 MB Notification: Performance of NFPackage.collectConstants: time 4.309e-05/0.2903, allocations: 9.5 kB / 382.3 MB, free: 12.98 MB / 302.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0004065/0.2908, allocations: 118.6 kB / 382.4 MB, free: 12.97 MB / 302.1 MB Notification: Performance of combineBinaries: time 0.0003143/0.2911, allocations: 281.1 kB / 382.7 MB, free: 12.82 MB / 302.1 MB Notification: Performance of replaceArrayConstructors: time 0.0001761/0.2912, allocations: 195 kB / 382.9 MB, free: 12.7 MB / 302.1 MB Notification: Performance of NFVerifyModel.verify: time 3.914e-05/0.2913, allocations: 6.594 kB / 382.9 MB, free: 12.7 MB / 302.1 MB Notification: Performance of FrontEnd: time 3.84e-05/0.2913, allocations: 9.781 kB / 382.9 MB, free: 12.7 MB / 302.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 29 (18) * Number of variables: 29 (25) Notification: Performance of [SIM] Bindings: time 0.001368/0.2927, allocations: 0.9129 MB / 383.8 MB, free: 12.09 MB / 302.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.0004469/0.2931, allocations: 199.9 kB / 384 MB, free: 12.04 MB / 302.1 MB Notification: Performance of [SIM] Early Inline: time 0.001352/0.2945, allocations: 0.8563 MB / 384.8 MB, free: 11.96 MB / 302.1 MB Notification: Performance of [SIM] Simplify 1: time 0.0002672/0.2948, allocations: 158.6 kB / 385 MB, free: 11.85 MB / 302.1 MB Notification: Performance of [SIM] Alias: time 0.001034/0.2958, allocations: 0.5447 MB / 385.5 MB, free: 11.62 MB / 302.1 MB Notification: Performance of [SIM] Simplify 2: time 0.0002124/0.296, allocations: 155.2 kB / 385.7 MB, free: 11.5 MB / 302.1 MB Notification: Performance of [SIM] Remove Stream: time 9.521e-05/0.2961, allocations: 85.36 kB / 385.8 MB, free: 11.42 MB / 302.1 MB Notification: Performance of [SIM] Detect States: time 0.0002241/0.2963, allocations: 180.8 kB / 385.9 MB, free: 11.25 MB / 302.1 MB Notification: Performance of [SIM] Events: time 0.0001878/0.2965, allocations: 85.48 kB / 386 MB, free: 11.21 MB / 302.1 MB Notification: Performance of [SIM] Partitioning: time 0.0003938/0.2969, allocations: 261.8 kB / 386.3 MB, free: 11.1 MB / 302.1 MB Error: Internal error NBSorting.tarjan failed to sort system: System Variables (32/42) ************************** (1|1) [ALGB] (1) Real $FUN_4 (2|2) [ALGB] (1) Real $FUN_3 (3|3) [ALGB] (1) Real $FUN_2 (4|4) [DISC] (3) Boolean[3] $SEV_2 (5|7) [ALGB] (1) Real $FUN_1 (6|8) [DISC] (3) Boolean[3] $SEV_1 (7|11) [ALGB] (1) protected Real transferFunction.uInternal.im = transferFunction.u.im (8|12) [DISC] (3) Boolean[3] $SEV_0 (9|15) [ALGB] (1) protected Real transferFunction.bSum.im (10|16) [ALGB] (3) protected Real[3] transferFunction.aw.re (11|19) [ALGB] (1) input Real transferFunction.u.im (12|20) [ALGB] (1) output Real transferFunction.y.im (13|21) [ALGB] (1) Real complexToPolar.len (14|22) [ALGB] (1) protected Real[1] transferFunction.bw.im (15|23) [ALGB] (1) protected Real[1] transferFunction.bw.re (16|24) [ALGB] (1) Real lg_w = log10(logFrequencySweep.y) (17|25) [ALGB] (1) input Real transferFunction.u.re (18|26) [ALGB] (1) protected Real transferFunction.bSum.re (19|27) [ALGB] (1) protected Real transferFunction.aSum.im (20|28) [ALGB] (1) input Real complexToPolar.u.re (21|29) [ALGB] (3) protected Real[3] transferFunction.aw.im (22|32) [ALGB] (1) output Real const.y.re (23|33) [ALGB] (1) input Real complexToPolar.u.im (24|34) [ALGB] (1) Real logFrequencySweep.y (25|35) [ALGB] (1) Real dB = 20.0 * log10(complexToPolar.len) (26|36) [DISC] (1) Boolean $TEV_1 (27|37) [DISC] (1) Boolean $TEV_0 (28|38) [ALGB] (1) Real phi = phi (29|39) [ALGB] (1) output Real const.y.im (30|40) [ALGB] (1) protected Real transferFunction.uInternal.re = transferFunction.u.re (31|41) [ALGB] (1) protected Real transferFunction.aSum.re (32|42) [ALGB] (1) output Real transferFunction.y.re System Equations (29/39) ************************** (1|1) [SCAL] (1) transferFunction.bSum.im = $FUN_2 ($RES_SIM_36) (2|2) [FOR-] (3) ($RES_EVT_46) (2|2) [----] for i in 1:3 loop (2|2) [----] [SCAL] (1) $SEV_1[i] = mod(3 - i, 4) == 1 ($RES_EVT_47) (2|2) [----] end for; (3|5) [SCAL] (1) transferFunction.aSum.re = $FUN_3 ($RES_SIM_37) (4|6) [SCAL] (1) transferFunction.aSum.im = $FUN_4 ($RES_SIM_38) (5|7) [FOR-] (3) ($RES_EVT_48) (5|7) [----] for i in 1:3 loop (5|7) [----] [SCAL] (1) $SEV_2[i] = mod(3 - i, 4) == 2 ($RES_EVT_49) (5|7) [----] end for; (6|10) [SCAL] (1) transferFunction.y.re = ((transferFunction.bSum.re * transferFunction.u.re - transferFunction.bSum.im * transferFunction.u.im) * transferFunction.aSum.re + (transferFunction.bSum.re * transferFunction.u.im + transferFunction.bSum.im * transferFunction.u.re) * transferFunction.aSum.im) / (transferFunction.aSum.re * transferFunction.aSum.re + transferFunction.aSum.im * transferFunction.aSum.im) ($RES_SIM_39) (7|11) [SCAL] (1) transferFunction.y.im = complexToPolar.u.im ($RES_SIM_9) (8|12) [SCAL] (1) logFrequencySweep.y = if $TEV_0 then logFrequencySweep.wMin else if $TEV_1 then logFrequencySweep.wMin * (logFrequencySweep.wMax / logFrequencySweep.wMin) ^ min(1.0, (time - logFrequencySweep.startTime) / max(logFrequencySweep.duration, 2.220446049250313e-16)) else logFrequencySweep.wMax ($RES_SIM_8) (9|13) [SCAL] (1) $FUN_1 = sum(transferFunction.bw.re) ($RES_AUX_30) (10|14) [SCAL] (1) lg_w = log10(logFrequencySweep.y) ($RES_AUX_24) (11|15) [RECD] (2) const.y = const.k ($RES_SIM_7) (12|17) [SCAL] (1) 0.05 * dB = log10(complexToPolar.len) ($RES_AUX_25) (13|18) [SCAL] (1) complexToPolar.len = sqrt(complexToPolar.u.re ^ 2.0 + complexToPolar.u.im ^ 2.0) ($RES_AUX_26) (14|19) [SCAL] (1) transferFunction.y.re = complexToPolar.u.re ($RES_SIM_10) (15|20) [SCAL] (1) $FUN_4 = sum(transferFunction.aw.im) ($RES_AUX_27) (16|21) [SCAL] (1) $FUN_3 = sum(transferFunction.aw.re) ($RES_AUX_28) (17|22) [SCAL] (1) $FUN_2 = sum(transferFunction.bw.im) ($RES_AUX_29) (18|23) [SCAL] (1) const.y.im = transferFunction.u.im ($RES_SIM_12) (19|24) [SCAL] (1) const.y.re = transferFunction.u.re ($RES_SIM_13) (20|25) [SCAL] (1) phi = if complexToPolar.useConjugateInput then atan2(-complexToPolar.u.im, complexToPolar.u.re) else atan2(complexToPolar.u.im, complexToPolar.u.re) ($RES_SIM_0) (21|26) [FOR-] (3) ($RES_SIM_22) (21|26) [----] for i in 1:3 loop (21|26) [----] [SCAL] (1) transferFunction.aw[i].im = (Complex.'constructor'.fromReal(logFrequencySweep.y ^ (3 - i) * transferFunction.a[i] * (if $SEV_0[i] then 1.0 else if $SEV_1[i] then 0.0 else if $SEV_2[i] then -1.0 else 0.0), logFrequencySweep.y ^ (3 - i) * transferFunction.a[i] * (if $SEV_0[i] then 0.0 else if $SEV_1[i] then 1.0 else if $SEV_2[i] then 0.0 else -1.0))).im ($RES_SIM_23) (21|26) [----] end for; (22|29) [RECD] (2) transferFunction.uInternal = transferFunction.u ($RES_BND_17) (23|31) [SCAL] (1) transferFunction.bw[1].re = transferFunction.b[1] ($RES_SIM_32) (24|32) [SCAL] (1) $TEV_0 = time < logFrequencySweep.startTime ($RES_EVT_42) (25|33) [SCAL] (1) $TEV_1 = time < (logFrequencySweep.startTime + max(logFrequencySweep.duration, 2.220446049250313e-16)) ($RES_EVT_43) (26|34) [SCAL] (1) transferFunction.bw[1].im = 0.0 ($RES_SIM_34) (27|35) [SCAL] (1) transferFunction.y.im = ((transferFunction.bSum.re * transferFunction.u.im + transferFunction.bSum.im * transferFunction.u.re) * transferFunction.aSum.re - (transferFunction.bSum.re * transferFunction.u.re - transferFunction.bSum.im * transferFunction.u.im) * transferFunction.aSum.im) / (transferFunction.aSum.re * transferFunction.aSum.re + transferFunction.aSum.im * transferFunction.aSum.im) ($RES_SIM_40) (28|36) [FOR-] (3) ($RES_EVT_44) (28|36) [----] for i in 1:3 loop (28|36) [----] [SCAL] (1) $SEV_0[i] = mod(3 - i, 4) == 0 ($RES_EVT_45) (28|36) [----] end for; (29|39) [SCAL] (1) transferFunction.bSum.re = $FUN_1 ($RES_SIM_35) =================== Scalar Matching =================== variable to equation ********************** var 1 --> eqn 20 var 2 --> eqn 5 var 3 --> eqn 22 var 4 --> eqn 7 var 5 --> eqn 8 var 6 --> eqn 9 var 7 --> eqn 13 var 8 --> eqn 2 var 9 --> eqn 3 var 10 --> eqn 4 var 11 --> eqn 30 var 12 --> eqn 36 var 13 --> eqn 37 var 14 --> eqn 38 var 15 --> eqn 1 var 16 --> eqn -1 var 17 --> eqn -1 var 18 --> eqn 21 var 19 --> eqn 23 var 20 --> eqn 35 var 21 --> eqn 17 var 22 --> eqn 34 var 23 --> eqn 31 var 24 --> eqn 14 var 25 --> eqn 24 var 26 --> eqn 39 var 27 --> eqn 6 var 28 --> eqn 18 var 29 --> eqn 26 var 30 --> eqn 27 var 31 --> eqn 28 var 32 --> eqn 15 var 33 --> eqn 11 var 34 --> eqn 12 var 35 --> eqn -1 var 36 --> eqn 33 var 37 --> eqn 32 var 38 --> eqn 25 var 39 --> eqn 16 var 40 --> eqn 29 var 41 --> eqn 10 var 42 --> eqn 19 equation to variable ********************** eqn 1 --> var 15 eqn 2 --> var 8 eqn 3 --> var 9 eqn 4 --> var 10 eqn 5 --> var 2 eqn 6 --> var 27 eqn 7 --> var 4 eqn 8 --> var 5 eqn 9 --> var 6 eqn 10 --> var 41 eqn 11 --> var 33 eqn 12 --> var 34 eqn 13 --> var 7 eqn 14 --> var 24 eqn 15 --> var 32 eqn 16 --> var 39 eqn 17 --> var 21 eqn 18 --> var 28 eqn 19 --> var 42 eqn 20 --> var 1 eqn 21 --> var 18 eqn 22 --> var 3 eqn 23 --> var 19 eqn 24 --> var 25 eqn 25 --> var 38 eqn 26 --> var 29 eqn 27 --> var 30 eqn 28 --> var 31 eqn 29 --> var 40 eqn 30 --> var 11 eqn 31 --> var 23 eqn 32 --> var 37 eqn 33 --> var 36 eqn 34 --> var 22 eqn 35 --> var 20 eqn 36 --> var 12 eqn 37 --> var 13 eqn 38 --> var 14 eqn 39 --> var 26 " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 2.7099642519606277] Failed to read output from testmodel.py, exit status != 0: ['time', 'logFrequencySweep.y', 'const.y.re', 'const.y.im', 'transferFunction.y.re', 'transferFunction.y.im'] 0.3078506739693694 0.323146517 0.028553174 Calling exit ...