Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_3.2.3_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.00164/0.00164, allocations: 111.9 kB / 22 MB, free: 4.594 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.00181/0.00181, allocations: 217.5 kB / 25.3 MB, free: 2.898 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.886/1.886, allocations: 207.7 MB / 236.2 MB, free: 9.758 MB / 190.1 MB " [Timeout remaining time 178] Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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_3.2.3_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_3.2.3_Modelica.ComplexBlocks.Examples.ShowTransferFunction") [Timeout 660] "Notification: Performance of FrontEnd - Absyn->SCode: time 2.384e-05/2.384e-05, allocations: 2.281 kB / 348.5 MB, free: 9.484 MB / 286.1 MB Notification: Performance of NFInst.instantiate(Modelica.ComplexBlocks.Examples.ShowTransferFunction): time 0.003448/0.003472, allocations: 1.557 MB / 350.1 MB, free: 7.91 MB / 286.1 MB Notification: Performance of NFInst.instExpressions: time 0.00159/0.005062, allocations: 0.663 MB / 350.7 MB, free: 7.238 MB / 286.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 8.164e-05/0.005144, allocations: 0 / 350.7 MB, free: 7.238 MB / 286.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0003065/0.00545, allocations: 43.8 kB / 350.8 MB, free: 7.195 MB / 286.1 MB Notification: Performance of NFTyping.typeBindings: time 0.0002386/0.005689, allocations: 39.7 kB / 350.8 MB, free: 7.156 MB / 286.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.001367/0.007056, allocations: 0.5798 MB / 351.4 MB, free: 6.574 MB / 286.1 MB Notification: Performance of NFFlatten.flatten: time 0.0002775/0.007333, allocations: 135.6 kB / 351.5 MB, free: 6.441 MB / 286.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0001213/0.007454, allocations: 27.97 kB / 351.5 MB, free: 6.414 MB / 286.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0001686/0.007623, allocations: 67.64 kB / 351.6 MB, free: 6.348 MB / 286.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0001502/0.007773, allocations: 67.67 kB / 351.7 MB, free: 6.281 MB / 286.1 MB Notification: Performance of NFPackage.collectConstants: time 2.816e-05/0.007801, allocations: 12 kB / 351.7 MB, free: 6.27 MB / 286.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.0002492/0.00805, allocations: 111.9 kB / 351.8 MB, free: 6.16 MB / 286.1 MB Notification: Performance of combineBinaries: time 0.0002372/0.008288, allocations: 245.2 kB / 352 MB, free: 5.918 MB / 286.1 MB Notification: Performance of replaceArrayConstructors: time 0.0001601/0.008448, allocations: 181.6 kB / 352.2 MB, free: 5.738 MB / 286.1 MB Notification: Performance of NFVerifyModel.verify: time 4.105e-05/0.008489, allocations: 4 kB / 352.2 MB, free: 5.734 MB / 286.1 MB Notification: Performance of FrontEnd: time 2.963e-05/0.008518, allocations: 7.875 kB / 352.2 MB, free: 5.727 MB / 286.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.001184/0.009702, allocations: 0.8709 MB / 353.1 MB, free: 4.73 MB / 286.1 MB Notification: Performance of [SIM] FunctionAlias: time 0.0004391/0.01014, allocations: 214.2 kB / 353.3 MB, free: 4.508 MB / 286.1 MB Notification: Performance of [SIM] Early Inline: time 0.001426/0.01157, allocations: 1.052 MB / 354.3 MB, free: 3.43 MB / 286.1 MB Notification: Performance of [SIM] Simplify 1: time 0.0002998/0.01187, allocations: 167.4 kB / 354.5 MB, free: 3.219 MB / 286.1 MB Notification: Performance of [SIM] Alias: time 0.001109/0.01298, allocations: 0.568 MB / 355.1 MB, free: 2.57 MB / 286.1 MB Notification: Performance of [SIM] Simplify 2: time 0.0002526/0.01323, allocations: 170.6 kB / 355.2 MB, free: 2.363 MB / 286.1 MB Notification: Performance of [SIM] Remove Stream: time 0.0001318/0.01336, allocations: 88.38 kB / 355.3 MB, free: 2.25 MB / 286.1 MB Notification: Performance of [SIM] Detect States: time 0.0002559/0.01362, allocations: 204.5 kB / 355.5 MB, free: 1.996 MB / 286.1 MB Notification: Performance of [SIM] Events: time 0.0001783/0.0138, allocations: 81.05 kB / 355.6 MB, free: 1.914 MB / 286.1 MB Notification: Performance of [SIM] Partitioning: time 0.0004057/0.0142, allocations: 298.1 kB / 355.9 MB, free: 1.617 MB / 286.1 MB Error: Internal error NBSorting.tarjan failed to sort system: System Variables (34/40) ************************** (1|1) [ALGB] (1) Real $FUN_4 (2|2) [ALGB] (1) Real $FUN_3 (3|3) [ALGB] (1) Real $FUN_2 (4|4) [ALGB] (1) Real $FUN_1 (5|5) [ALGB] (1) protected Real transferFunction.uInternal.im = transferFunction.u.im (6|6) [DISC] (3) Boolean[3] $SEV_0 (7|9) [ALGB] (1) protected Real transferFunction.bSum.im (8|10) [ALGB] (3) protected Real[3] transferFunction.aw.re (9|13) [ALGB] (1) input Real transferFunction.u.im (10|14) [ALGB] (1) output Real transferFunction.y.im (11|15) [ALGB] (1) Real complexToPolar.len (12|16) [ALGB] (1) protected Real[1] transferFunction.bw.im (13|17) [ALGB] (1) protected Real[1] transferFunction.bw.re (14|18) [ALGB] (1) Real lg_w = log10(logFrequencySweep.y) (15|19) [ALGB] (1) input Real transferFunction.u.re (16|20) [ALGB] (1) protected Real transferFunction.bSum.re (17|21) [ALGB] (1) protected Real transferFunction.aSum.im (18|22) [ALGB] (1) input Real complexToPolar.u.re (19|23) [ALGB] (3) protected Real[3] transferFunction.aw.im (20|26) [ALGB] (1) output Real const.y.re (21|27) [ALGB] (1) input Real complexToPolar.u.im (22|28) [ALGB] (1) Real logFrequencySweep.y (23|29) [ALGB] (1) Real dB = 20.0 * log10(complexToPolar.len) (24|30) [DISC] (1) Boolean $TEV_1 (25|31) [DISC] (1) Boolean $TEV_0 (26|32) [ALGB] (1) Real phi = phi (27|33) [ALGB] (1) output Real const.y.im (28|34) [ALGB] (1) protected Real transferFunction.uInternal.re = transferFunction.u.re (29|35) [ALGB] (1) Real $FUN_8 (30|36) [ALGB] (1) protected Real transferFunction.aSum.re (31|37) [ALGB] (1) Real $FUN_7 (32|38) [ALGB] (1) output Real transferFunction.y.re (33|39) [ALGB] (1) Real $FUN_6 (34|40) [ALGB] (1) Real $FUN_5 System Equations (31/37) ************************** (1|1) [SCAL] (1) transferFunction.y.re = complexToPolar.u.re ($RES_SIM_10) (2|2) [SCAL] (1) const.y.im = transferFunction.u.im ($RES_SIM_12) (3|3) [SCAL] (1) const.y.re = transferFunction.u.re ($RES_SIM_13) (4|4) [SCAL] (1) transferFunction.bw[1].re = transferFunction.b[1] ($RES_SIM_35) (5|5) [SCAL] (1) transferFunction.bw[1].im = 0.0 ($RES_SIM_37) (6|6) [SCAL] (1) transferFunction.bSum.re = $FUN_3 ($RES_SIM_38) (7|7) [SCAL] (1) lg_w = log10(logFrequencySweep.y) ($RES_AUX_24) (8|8) [SCAL] (1) transferFunction.bSum.im = $FUN_4 ($RES_SIM_39) (9|9) [SCAL] (1) 0.05 * dB = log10(complexToPolar.len) ($RES_AUX_25) (10|10) [SCAL] (1) $FUN_8 = atan2(complexToPolar.u.im, complexToPolar.u.re) ($RES_AUX_26) (11|11) [SCAL] (1) $FUN_7 = atan2(-complexToPolar.u.im, complexToPolar.u.re) ($RES_AUX_27) (12|12) [SCAL] (1) $FUN_6 = sum(transferFunction.aw.im) ($RES_AUX_28) (13|13) [SCAL] (1) $FUN_5 = sum(transferFunction.aw.re) ($RES_AUX_29) (14|14) [SCAL] (1) $TEV_0 = time < logFrequencySweep.startTime ($RES_EVT_45) (15|15) [SCAL] (1) $TEV_1 = time < (logFrequencySweep.startTime + max(logFrequencySweep.duration, 2.220446049250313e-16)) ($RES_EVT_46) (16|16) [FOR-] (3) ($RES_EVT_47) (16|16) [----] for i in 1:3 loop (16|16) [----] [SCAL] (1) $SEV_0[i] = (-1) + i == 0 ($RES_EVT_48) (16|16) [----] end for; (17|19) [FOR-] (3) ($RES_SIM_22) (17|19) [----] for i in 1:3 loop (17|19) [----] [SCAL] (1) transferFunction.aw[i].im = (Complex.'constructor'.fromReal(transferFunction.a[i] * (if $SEV_0[i] then 1.0 else (Complex.'constructor'.fromReal(cos(((-1) + i) * atan2(logFrequencySweep.y, 0.0)) * exp(0.5 * ((-1) + i) * log(logFrequencySweep.y * logFrequencySweep.y)), sin(((-1) + i) * atan2(logFrequencySweep.y, 0.0)) * exp(0.5 * ((-1) + i) * log(logFrequencySweep.y * logFrequencySweep.y)))).re), transferFunction.a[i] * (if $SEV_0[i] then 0.0 else (Complex.'constructor'.fromReal(cos(((-1) + i) * atan2(logFrequencySweep.y, 0.0)) * exp(0.5 * ((-1) + i) * log(logFrequencySweep.y * logFrequencySweep.y)), sin(((-1) + i) * atan2(logFrequencySweep.y, 0.0)) * exp(0.5 * ((-1) + i) * log(logFrequencySweep.y * logFrequencySweep.y)))).im))).im ($RES_SIM_23) (17|19) [----] end for; (18|22) [SCAL] (1) transferFunction.aSum.re = $FUN_5 ($RES_SIM_40) (19|23) [SCAL] (1) transferFunction.aSum.im = $FUN_6 ($RES_SIM_41) (20|24) [RECD] (2) transferFunction.uInternal = transferFunction.u ($RES_BND_17) (21|26) [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_42) (22|27) [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_43) (23|28) [SCAL] (1) $FUN_4 = sum(transferFunction.bw.im) ($RES_AUX_30) (24|29) [SCAL] (1) $FUN_3 = sum(transferFunction.bw.re) ($RES_AUX_31) (25|30) [SCAL] (1) $FUN_2 = log10(logFrequencySweep.wMax) ($RES_AUX_32) (26|31) [SCAL] (1) $FUN_1 = log10(logFrequencySweep.wMin) ($RES_AUX_33) (27|32) [SCAL] (1) transferFunction.y.im = complexToPolar.u.im ($RES_SIM_9) (28|33) [SCAL] (1) logFrequencySweep.y = if $TEV_0 then logFrequencySweep.wMin else if $TEV_1 then 10.0 ^ ($FUN_1 + ($FUN_2 - $FUN_1) * min(1.0, (time - logFrequencySweep.startTime) / max(logFrequencySweep.duration, 2.220446049250313e-16))) else logFrequencySweep.wMax ($RES_SIM_8) (29|34) [RECD] (2) const.y = const.k ($RES_SIM_7) (30|36) [SCAL] (1) complexToPolar.len = (complexToPolar.u.re ^ 2.0 + complexToPolar.u.im ^ 2.0) ^ 0.5 ($RES_SIM_1) (31|37) [SCAL] (1) phi = if complexToPolar.useConjugateInput then $FUN_7 else $FUN_8 ($RES_SIM_0) =================== Scalar Matching =================== variable to equation ********************** var 1 --> eqn 28 var 2 --> eqn 29 var 3 --> eqn 30 var 4 --> eqn 31 var 5 --> eqn 25 var 6 --> eqn 16 var 7 --> eqn 17 var 8 --> eqn 18 var 9 --> eqn 8 var 10 --> eqn -1 var 11 --> eqn -1 var 12 --> eqn 13 var 13 --> eqn 2 var 14 --> eqn 32 var 15 --> eqn 36 var 16 --> eqn 5 var 17 --> eqn 4 var 18 --> eqn 7 var 19 --> eqn 3 var 20 --> eqn 6 var 21 --> eqn 23 var 22 --> eqn 1 var 23 --> eqn 19 var 24 --> eqn 20 var 25 --> eqn 21 var 26 --> eqn 34 var 27 --> eqn 10 var 28 --> eqn 33 var 29 --> eqn 9 var 30 --> eqn 15 var 31 --> eqn 14 var 32 --> eqn -1 var 33 --> eqn 35 var 34 --> eqn 24 var 35 --> eqn 37 var 36 --> eqn 27 var 37 --> eqn 11 var 38 --> eqn 26 var 39 --> eqn 12 var 40 --> eqn 22 equation to variable ********************** eqn 1 --> var 22 eqn 2 --> var 13 eqn 3 --> var 19 eqn 4 --> var 17 eqn 5 --> var 16 eqn 6 --> var 20 eqn 7 --> var 18 eqn 8 --> var 9 eqn 9 --> var 29 eqn 10 --> var 27 eqn 11 --> var 37 eqn 12 --> var 39 eqn 13 --> var 12 eqn 14 --> var 31 eqn 15 --> var 30 eqn 16 --> var 6 eqn 17 --> var 7 eqn 18 --> var 8 eqn 19 --> var 23 eqn 20 --> var 24 eqn 21 --> var 25 eqn 22 --> var 40 eqn 23 --> var 21 eqn 24 --> var 34 eqn 25 --> var 5 eqn 26 --> var 38 eqn 27 --> var 36 eqn 28 --> var 1 eqn 29 --> var 2 eqn 30 --> var 3 eqn 31 --> var 4 eqn 32 --> var 14 eqn 33 --> var 28 eqn 34 --> var 26 eqn 35 --> var 33 eqn 36 --> var 15 eqn 37 --> var 35 " [Timeout remaining time 660] [Calling sys.exit(0), Time elapsed: 2.7553768969955854] 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.025143274979200214 0.040795021 0.028950159000000003 Calling exit ...