Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0_Modelica.ComplexBlocks.Examples.ShowTransferFunction.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.001478/0.001478, allocations: 99.64 kB / 21.25 MB, free: 428 kB / 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.001499/0.001499, allocations: 207.2 kB / 24.55 MB, free: 3.727 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.636/1.636, allocations: 230.6 MB / 258.3 MB, free: 7.785 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+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(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_4.1.0_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_4.1.0_Modelica.ComplexBlocks.Examples.ShowTransferFunction") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 3.607e-05/3.607e-05, allocations: 5.094 kB / 379 MB, free: 2.484 MB / 302.1 MB Notification: Performance of NFInst.instantiate(Modelica.ComplexBlocks.Examples.ShowTransferFunction): time 0.00331/0.003347, allocations: 1.669 MB / 380.7 MB, free: 0.8047 MB / 302.1 MB Notification: Performance of NFInst.instExpressions: time 0.001612/0.004958, allocations: 0.7204 MB / 381.4 MB, free: 80 kB / 302.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 7.173e-05/0.00503, allocations: 4 kB / 381.4 MB, free: 76 kB / 302.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0003174/0.005348, allocations: 47.73 kB / 381.5 MB, free: 28 kB / 302.1 MB Notification: Performance of NFTyping.typeBindings: time 0.2546/0.26, allocations: 40.8 kB / 381.5 MB, free: 13.05 MB / 302.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.001404/0.2614, allocations: 471 kB / 382 MB, free: 13.05 MB / 302.1 MB Notification: Performance of NFFlatten.flatten: time 0.000358/0.2617, allocations: 153.1 kB / 382.1 MB, free: 13.05 MB / 302.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0001532/0.2619, allocations: 19.58 kB / 382.1 MB, free: 13.04 MB / 302.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0001284/0.262, allocations: 67.52 kB / 382.2 MB, free: 13.04 MB / 302.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0002489/0.2623, allocations: 81.19 kB / 382.3 MB, free: 13.02 MB / 302.1 MB Notification: Performance of NFPackage.collectConstants: time 3.285e-05/0.2623, allocations: 10 kB / 382.3 MB, free: 13.02 MB / 302.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0002985/0.2626, allocations: 120.2 kB / 382.4 MB, free: 13.01 MB / 302.1 MB Notification: Performance of combineBinaries: time 0.0002328/0.2628, allocations: 274.4 kB / 382.7 MB, free: 12.87 MB / 302.1 MB Notification: Performance of replaceArrayConstructors: time 0.0001284/0.2629, allocations: 199.6 kB / 382.9 MB, free: 12.74 MB / 302.1 MB Notification: Performance of NFVerifyModel.verify: time 3.06e-05/0.263, allocations: 5.812 kB / 382.9 MB, free: 12.74 MB / 302.1 MB Notification: Performance of FrontEnd: time 2.898e-05/0.263, allocations: 2.719 kB / 382.9 MB, free: 12.74 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.001055/0.2641, allocations: 0.9156 MB / 383.8 MB, free: 12.14 MB / 302.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.0003427/0.2644, allocations: 194.1 kB / 384 MB, free: 12.09 MB / 302.1 MB Notification: Performance of [SIM] Early Inline: time 0.001299/0.2657, allocations: 0.8531 MB / 384.8 MB, free: 12.02 MB / 302.1 MB Notification: Performance of [SIM] Simplify 1: time 0.0002384/0.2659, allocations: 164.9 kB / 385 MB, free: 11.91 MB / 302.1 MB Notification: Performance of [SIM] Alias: time 0.001145/0.2671, allocations: 0.5555 MB / 385.5 MB, free: 11.69 MB / 302.1 MB Notification: Performance of [SIM] Simplify 2: time 0.0002501/0.2673, allocations: 158.9 kB / 385.7 MB, free: 11.57 MB / 302.1 MB Notification: Performance of [SIM] Remove Stream: time 9.042e-05/0.2674, allocations: 82.08 kB / 385.8 MB, free: 11.51 MB / 302.1 MB Notification: Performance of [SIM] Detect States: time 0.0002037/0.2676, allocations: 177.7 kB / 386 MB, free: 11.34 MB / 302.1 MB Notification: Performance of [SIM] Events: time 0.0001922/0.2678, allocations: 84.94 kB / 386 MB, free: 11.3 MB / 302.1 MB Notification: Performance of [SIM] Partitioning: time 0.0004182/0.2682, allocations: 257.9 kB / 386.3 MB, free: 11.2 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.6864541890099645] 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.2787757479818538 0.29633571000000003 0.029659018000000002 Calling exit ...