Bug #4639
closedpower ramping shows a weird behaviour after poweroff
100%
Description
killing osmo-bsc with ctrl-c leads to this on the osmo-trx-uhd side:
Thu Jul 2 14:32:30 2020 DTRXDDL <0003> Transceiver.cpp:1032 [tid=139738993161984][chan=0] Rx TRXD message (hdr_ver=1): fn=1765622, tn=7, burst_len=148 Thu Jul 2 14:32:30 2020 DMAIN <0000> Transceiver.cpp:357 [tid=139739153299392] Stopping the device UUThu Jul 2 14:32:30 2020 DMAIN <0000> Transceiver.cpp:370 [tid=139739153299392] Transceiver stopped Thu Jul 2 14:32:30 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP POWEROFF 0' Thu Jul 2 14:32:30 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'POWEROFF' Thu Jul 2 14:32:30 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP POWEROFF 0' Thu Jul 2 14:32:31 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 25' Thu Jul 2 14:32:31 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:32:31 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:32:31 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 25' Thu Jul 2 14:32:31 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:32:31 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:32:32 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 27' Thu Jul 2 14:32:32 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:32:32 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:32:32 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 27' Thu Jul 2 14:32:32 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:32:32 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:32:33 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 29' Thu Jul 2 14:32:33 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:32:33 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:32:33 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 29' Thu Jul 2 14:32:33 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:32:33 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:32:34 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 31' Thu Jul 2 14:32:34 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:32:34 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:32:34 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 31' Thu Jul 2 14:32:34 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:32:34 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:32:35 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:32:35 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:35 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:35 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:32:35 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:35 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:36 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:32:36 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:36 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:36 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:32:36 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:36 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:38 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'POWEROFF' Thu Jul 2 14:32:38 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP POWEROFF 0' Thu Jul 2 14:32:39 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 25' Thu Jul 2 14:32:39 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:32:39 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:32:39 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 25' Thu Jul 2 14:32:39 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:32:39 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:32:40 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 27' Thu Jul 2 14:32:40 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:32:40 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:32:40 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 27' Thu Jul 2 14:32:40 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:32:40 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:32:41 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 29' Thu Jul 2 14:32:41 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:32:41 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:32:41 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 29' Thu Jul 2 14:32:41 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:32:41 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:32:42 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 31' Thu Jul 2 14:32:42 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:32:42 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:32:42 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 31' Thu Jul 2 14:32:42 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:32:42 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:32:43 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:32:43 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:43 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:43 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:32:43 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:43 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:44 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:32:44 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:44 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:44 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:32:44 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:44 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:46 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'POWEROFF' Thu Jul 2 14:32:46 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP POWEROFF 0' Thu Jul 2 14:32:47 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 25' Thu Jul 2 14:32:47 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:32:47 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:32:47 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 25' Thu Jul 2 14:32:47 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:32:47 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:32:48 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 27' Thu Jul 2 14:32:48 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:32:48 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:32:48 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 27' Thu Jul 2 14:32:48 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:32:48 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:32:49 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 29' Thu Jul 2 14:32:49 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:32:49 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:32:49 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 29' Thu Jul 2 14:32:49 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:32:49 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:32:50 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 31' Thu Jul 2 14:32:50 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:32:50 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:32:50 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 31' Thu Jul 2 14:32:50 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:32:50 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:32:51 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:32:51 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:51 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:51 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:32:51 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:51 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:52 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:32:52 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:52 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:52 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:32:52 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:52 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:54 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'POWEROFF' Thu Jul 2 14:32:54 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP POWEROFF 0' Thu Jul 2 14:32:55 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 25' Thu Jul 2 14:32:55 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:32:55 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:32:55 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 25' Thu Jul 2 14:32:55 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:32:55 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:32:56 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 27' Thu Jul 2 14:32:56 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:32:56 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:32:56 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 27' Thu Jul 2 14:32:56 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:32:56 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:32:57 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 29' Thu Jul 2 14:32:57 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:32:57 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:32:57 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 29' Thu Jul 2 14:32:57 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:32:57 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:32:58 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 31' Thu Jul 2 14:32:58 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:32:58 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:32:58 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 31' Thu Jul 2 14:32:58 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:32:58 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:32:59 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:32:59 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:59 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:32:59 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:32:59 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:32:59 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:00 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:33:00 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:00 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:00 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:33:00 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:00 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:02 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'POWEROFF' Thu Jul 2 14:33:02 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP POWEROFF 0' Thu Jul 2 14:33:03 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 25' Thu Jul 2 14:33:03 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:33:03 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:33:03 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 25' Thu Jul 2 14:33:03 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:33:03 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:33:04 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 27' Thu Jul 2 14:33:04 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:33:04 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:33:04 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 27' Thu Jul 2 14:33:04 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:33:04 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:33:05 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 29' Thu Jul 2 14:33:05 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:33:05 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:33:05 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 29' Thu Jul 2 14:33:05 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:33:05 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:33:06 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 31' Thu Jul 2 14:33:06 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:33:06 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:33:06 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 31' Thu Jul 2 14:33:06 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:33:06 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:33:07 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:33:07 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:07 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:07 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:33:07 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:07 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:08 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:33:08 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:08 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:08 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:33:08 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:08 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:10 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'POWEROFF' Thu Jul 2 14:33:10 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP POWEROFF 0' Thu Jul 2 14:33:11 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 25' Thu Jul 2 14:33:11 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:33:11 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:33:11 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 25' Thu Jul 2 14:33:11 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:33:11 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:33:12 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 27' Thu Jul 2 14:33:12 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:33:12 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:33:12 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 27' Thu Jul 2 14:33:12 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:33:12 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:33:13 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 29' Thu Jul 2 14:33:13 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:33:13 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:33:13 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 29' Thu Jul 2 14:33:13 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:33:13 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:33:14 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 31' Thu Jul 2 14:33:14 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:33:14 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:33:14 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 31' Thu Jul 2 14:33:14 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:33:14 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:33:15 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:33:15 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:15 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:15 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:33:15 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:15 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:16 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:33:16 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:16 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:16 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:33:16 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:16 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:18 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'POWEROFF' Thu Jul 2 14:33:18 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP POWEROFF 0' Thu Jul 2 14:33:19 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 25' Thu Jul 2 14:33:19 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:33:19 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:33:19 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 25' Thu Jul 2 14:33:19 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 64.75dB (asked for 64.75dB) Thu Jul 2 14:33:19 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 25' Thu Jul 2 14:33:20 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 27' Thu Jul 2 14:33:20 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:33:20 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:33:20 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 27' Thu Jul 2 14:33:20 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 62.75dB (asked for 62.75dB) Thu Jul 2 14:33:20 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 27' Thu Jul 2 14:33:21 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 29' Thu Jul 2 14:33:21 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:33:21 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:33:21 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 29' Thu Jul 2 14:33:21 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 60.75dB (asked for 60.75dB) Thu Jul 2 14:33:21 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 29' Thu Jul 2 14:33:22 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 31' Thu Jul 2 14:33:22 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:33:22 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:33:22 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 31' Thu Jul 2 14:33:22 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 58.75dB (asked for 58.75dB) Thu Jul 2 14:33:22 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 31' Thu Jul 2 14:33:23 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=0] command is 'SETPOWER 33' Thu Jul 2 14:33:23 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:23 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=0] response is 'RSP SETPOWER 0 33' Thu Jul 2 14:33:23 2020 DTRXCTRL <0002> Transceiver.cpp:832 [tid=139739153299392][chan=1] command is 'SETPOWER 33' Thu Jul 2 14:33:23 2020 DDEV <0005> UHDDevice.cpp:391 [tid=139739153299392] Set TX gain to 56.75dB (asked for 56.75dB) Thu Jul 2 14:33:23 2020 DTRXCTRL <0002> Transceiver.cpp:980 [tid=139739153299392][chan=1] response is 'RSP SETPOWER 0 33' [0;m
Updated by pespin almost 4 years ago
- Assignee changed from pespin to Hoernchen
Can you explain more in detail what you see wrong in here?
The interesting part when talking about ramping down is actually on osmo-bts-trx side, not on osmo-trx side, so I'm lacking osmo-bts-trx logs to understand the full picture.
All I see is the BTS sending the POWEROFF command several times even after it was ACKED, and then before/after doing ramping down.
Please provide detailed description on the issue and osmo-bts-trx logs, as well as related tx power config options in use.
Updated by Hoernchen almost 4 years ago
- Assignee changed from Hoernchen to pespin
osmo-bts is wrapped with the usual restart script, but tries to ramp upon startup until it notices that there is no bsc:
((*)) | / \ OsmoBTS 20200702145119599 DL1C <0006> l1_if.c:267 phy0.0: Delaying provision, TRX not yet assigned to phy instance 20200702145119599 DL1C <0006> l1_if.c:267 phy0.1: Delaying provision, TRX not yet assigned to phy instance 20200702145119601 DLCTRL <0017> control_if.c:911 CTRL at 127.0.0.1 4238 20200702145119601 DLGLOBAL <0010> telnet_interface.c:104 Available via telnet 127.0.0.1 4241 20200702145119601 DPCU <0009> pcu_sock.c:1003 Started listening on PCU socket: /tmp/osmo_pcu 20200702145119601 DLINP <0012> input/ipaccess.c:1029 enabling ipaccess BTS mode, OML connecting to 127.0.0.1:3002 20200702145119601 DL1C <0006> phy_link.c:58 phy0: PHY link state change shutdown -> connecting 20200702145119601 DL1C <0006> scheduler.c:589 Init scheduler for trx=0 20200702145119602 DTRX <000b> trx_if.c:1213 phy0.0: Open transceiver 20200702145119602 DTRX <000b> trx_if.c:247 phy0.0: Enqueuing TRX control command 'CMD POWEROFF' 20200702145119602 DL1C <0006> scheduler.c:589 Init scheduler for trx=1 20200702145119602 DTRX <000b> trx_if.c:1213 phy0.1: Open transceiver 20200702145119602 DABIS <000d> abis.c:143 E1L(0) Signalling link down 20200702145119602 DOML <0001> bts_shutdown_fsm.c:207 BTS_SHUTDOWN(bts0)[0x6120000003a0]{NONE}: Shutting down BTS, reason: Abis close 20200702145119602 DOML <0001> bts_shutdown_fsm.c:208 BTS_SHUTDOWN(bts0)[0x6120000003a0]{NONE}: Received Event BTS_SHUTDOWN_EV_START 20200702145119602 DOML <0001> bts_shutdown_fsm.c:45 BTS_SHUTDOWN(bts0)[0x6120000003a0]{NONE}: state_chg to WAIT_RAMP_DOWN_COMPL 20200702145119602 DL1C <0006> tx_power.c:251 (bts=0,trx=0) power_ramp_start(cur=0, tgt=-10000, bypass) 20200702145119602 DL1C <0006> tx_power.c:251 (bts=0,trx=1) power_ramp_start(cur=0, tgt=-10000, bypass) 20200702145119602 DTRX <000b> trx_if.c:641 phy0.0: Response message: 'RSP POWEROFF 0' 20200702145120602 DL1C <0006> tx_power.c:181 (bts=0,trx=1) ramping TRX board output power to -2000 mdBm. 20200702145120602 DTRX <000b> trx_if.c:247 phy0.1: Enqueuing TRX control command 'CMD SETPOWER 25' 20200702145120602 DL1C <0006> tx_power.c:181 (bts=0,trx=0) ramping TRX board output power to -2000 mdBm. 20200702145120602 DTRX <000b> trx_if.c:247 phy0.0: Enqueuing TRX control command 'CMD SETPOWER 25' 20200702145120606 DTRX <000b> trx_if.c:641 phy0.1: Response message: 'RSP SETPOWER 0 25' 20200702145120606 DTRX <000b> trx_if.c:641 phy0.0: Response message: 'RSP SETPOWER 0 25' 20200702145121606 DL1C <0006> tx_power.c:181 (bts=0,trx=0) ramping TRX board output power to -4000 mdBm. 20200702145121606 DTRX <000b> trx_if.c:247 phy0.0: Enqueuing TRX control command 'CMD SETPOWER 27' 20200702145121607 DL1C <0006> tx_power.c:181 (bts=0,trx=1) ramping TRX board output power to -4000 mdBm. 20200702145121607 DTRX <000b> trx_if.c:247 phy0.1: Enqueuing TRX control command 'CMD SETPOWER 27' 20200702145121608 DTRX <000b> trx_if.c:641 phy0.0: Response message: 'RSP SETPOWER 0 27' 20200702145121609 DTRX <000b> trx_if.c:641 phy0.1: Response message: 'RSP SETPOWER 0 27' 20200702145122608 DL1C <0006> tx_power.c:181 (bts=0,trx=0) ramping TRX board output power to -6000 mdBm. 20200702145122609 DTRX <000b> trx_if.c:247 phy0.0: Enqueuing TRX control command 'CMD SETPOWER 29' 20200702145122609 DL1C <0006> tx_power.c:181 (bts=0,trx=1) ramping TRX board output power to -6000 mdBm. 20200702145122610 DTRX <000b> trx_if.c:247 phy0.1: Enqueuing TRX control command 'CMD SETPOWER 29' 20200702145122610 DTRX <000b> trx_if.c:641 phy0.0: Response message: 'RSP SETPOWER 0 29' 20200702145122612 DTRX <000b> trx_if.c:641 phy0.1: Response message: 'RSP SETPOWER 0 29' 20200702145123611 DL1C <0006> tx_power.c:181 (bts=0,trx=0) ramping TRX board output power to -8000 mdBm. 20200702145123611 DTRX <000b> trx_if.c:247 phy0.0: Enqueuing TRX control command 'CMD SETPOWER 31' 20200702145123612 DL1C <0006> tx_power.c:181 (bts=0,trx=1) ramping TRX board output power to -8000 mdBm. 20200702145123612 DTRX <000b> trx_if.c:247 phy0.1: Enqueuing TRX control command 'CMD SETPOWER 31' 20200702145123613 DTRX <000b> trx_if.c:641 phy0.0: Response message: 'RSP SETPOWER 0 31' 20200702145123614 DTRX <000b> trx_if.c:641 phy0.1: Response message: 'RSP SETPOWER 0 31' 20200702145124613 DL1C <0006> tx_power.c:181 (bts=0,trx=0) ramping TRX board output power to -10000 mdBm. 20200702145124613 DTRX <000b> trx_if.c:247 phy0.0: Enqueuing TRX control command 'CMD SETPOWER 33' 20200702145124614 DL1C <0006> tx_power.c:181 (bts=0,trx=1) ramping TRX board output power to -10000 mdBm. 20200702145124614 DTRX <000b> trx_if.c:247 phy0.1: Enqueuing TRX control command 'CMD SETPOWER 33' 20200702145124615 DTRX <000b> trx_if.c:641 phy0.0: Response message: 'RSP SETPOWER 0 33' 20200702145124615 DOML <0001> bts_shutdown_fsm.c:51 BTS_SHUTDOWN(bts0)[0x6120000003a0]{WAIT_RAMP_DOWN_COMPL}: Received Event BTS_SHUTDOWN_EV_TRX_RAMP_COMPL 20200702145124615 DOML <0001> bts_shutdown_fsm.c:80 BTS_SHUTDOWN(bts0)[0x6120000003a0]{WAIT_RAMP_DOWN_COMPL}: (bts=0,trx=0) Ramping down complete, 0 TRX remaining 20200702145124615 DOML <0001> bts_shutdown_fsm.c:82 BTS_SHUTDOWN(bts0)[0x6120000003a0]{WAIT_RAMP_DOWN_COMPL}: state_chg to WAIT_TRX_CLOSED 20200702145124615 DL1C <0006> scheduler.c:614 Exit scheduler for trx=1 20200702145124615 DL1C <0006> scheduler.c:589 Init scheduler for trx=1 20200702145124615 DL1C <0006> tx_power.c:251 (bts=0,trx=1) power_ramp_start(cur=-10000, tgt=-10000, bypass) 20200702145124615 DL1C <0006> scheduler.c:614 Exit scheduler for trx=0 20200702145124615 DL1C <0006> scheduler.c:589 Init scheduler for trx=0 20200702145124616 DL1C <0006> tx_power.c:251 (bts=0,trx=0) power_ramp_start(cur=-10000, tgt=-10000, bypass) 20200702145124616 DOML <0001> bts_shutdown_fsm.c:215 BTS_SHUTDOWN(bts0)[0x6120000003a0]{WAIT_TRX_CLOSED}: Received Event BTS_SHUTDOWN_ST_WAIT_TRX_CLOSED 20200702145124616 DOML <0001> bts_shutdown_fsm.c:116 BTS_SHUTDOWN(bts0)[0x6120000003a0]{WAIT_TRX_CLOSED}: (bts=0,trx=1) TRX closed, 2 TRX remaining 20200702145124616 DOML <0001> oml.c:351 OC=RADIO-CARRIER INST=(00,01,ff) AVAIL STATE Power off -> Off line 20200702145124616 DOML <0001> oml.c:358 OC=RADIO-CARRIER INST=(00,01,ff) OPER STATE NULL -> Disabled 20200702145124616 DOML <0001> oml.c:351 OC=BASEBAND-TRANSCEIVER INST=(00,01,ff) AVAIL STATE Power off -> Off line 20200702145124616 DOML <0001> oml.c:358 OC=BASEBAND-TRANSCEIVER INST=(00,01,ff) OPER STATE NULL -> Disabled 20200702145124616 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,01,00) AVAIL STATE Power off -> Off line 20200702145124616 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,01,00) OPER STATE NULL -> Disabled 20200702145124616 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,01,01) AVAIL STATE Power off -> Off line 20200702145124616 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,01,01) OPER STATE NULL -> Disabled 20200702145124616 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,01,02) AVAIL STATE Power off -> Off line 20200702145124616 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,01,02) OPER STATE NULL -> Disabled 20200702145124616 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,01,03) AVAIL STATE Power off -> Off line 20200702145124617 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,01,03) OPER STATE NULL -> Disabled 20200702145124617 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,01,04) AVAIL STATE Power off -> Off line 20200702145124617 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,01,04) OPER STATE NULL -> Disabled 20200702145124617 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,01,05) AVAIL STATE Power off -> Off line 20200702145124617 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,01,05) OPER STATE NULL -> Disabled 20200702145124617 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,01,06) AVAIL STATE Power off -> Off line 20200702145124617 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,01,06) OPER STATE NULL -> Disabled 20200702145124617 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,01,07) AVAIL STATE Power off -> Off line 20200702145124617 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,01,07) OPER STATE NULL -> Disabled 20200702145124617 DOML <0001> bts_shutdown_fsm.c:215 BTS_SHUTDOWN(bts0)[0x6120000003a0]{WAIT_TRX_CLOSED}: Received Event BTS_SHUTDOWN_ST_WAIT_TRX_CLOSED 20200702145124617 DOML <0001> bts_shutdown_fsm.c:116 BTS_SHUTDOWN(bts0)[0x6120000003a0]{WAIT_TRX_CLOSED}: (bts=0,trx=0) TRX closed, 1 TRX remaining 20200702145124617 DOML <0001> oml.c:351 OC=RADIO-CARRIER INST=(00,00,ff) AVAIL STATE Power off -> Off line 20200702145124617 DOML <0001> oml.c:358 OC=RADIO-CARRIER INST=(00,00,ff) OPER STATE NULL -> Disabled 20200702145124617 DOML <0001> oml.c:351 OC=BASEBAND-TRANSCEIVER INST=(00,00,ff) AVAIL STATE Power off -> Off line 20200702145124618 DOML <0001> oml.c:358 OC=BASEBAND-TRANSCEIVER INST=(00,00,ff) OPER STATE NULL -> Disabled 20200702145124618 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,00,00) AVAIL STATE Power off -> Off line 20200702145124618 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,00,00) OPER STATE NULL -> Disabled 20200702145124618 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,00,01) AVAIL STATE Power off -> Off line 20200702145124618 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,00,01) OPER STATE NULL -> Disabled 20200702145124618 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,00,02) AVAIL STATE Power off -> Off line 20200702145124618 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,00,02) OPER STATE NULL -> Disabled 20200702145124618 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,00,03) AVAIL STATE Power off -> Off line 20200702145124618 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,00,03) OPER STATE NULL -> Disabled 20200702145124618 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,00,04) AVAIL STATE Power off -> Off line 20200702145124618 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,00,04) OPER STATE NULL -> Disabled 20200702145124618 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,00,05) AVAIL STATE Power off -> Off line 20200702145124618 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,00,05) OPER STATE NULL -> Disabled 20200702145124619 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,00,06) AVAIL STATE Power off -> Off line 20200702145124619 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,00,06) OPER STATE NULL -> Disabled 20200702145124619 DOML <0001> oml.c:351 OC=CHANNEL INST=(00,00,07) AVAIL STATE Power off -> Off line 20200702145124619 DOML <0001> oml.c:358 OC=CHANNEL INST=(00,00,07) OPER STATE NULL -> Disabled 20200702145124619 DTRX <000b> trx_if.c:641 phy0.1: Response message: 'RSP SETPOWER 0 33' 20200702145125616 DL1C <0006> tx_power.c:181 (bts=0,trx=0) ramping TRX board output power to -10000 mdBm. 20200702145125616 DTRX <000b> trx_if.c:247 phy0.0: Enqueuing TRX control command 'CMD SETPOWER 33' 20200702145125616 DL1C <0006> tx_power.c:181 (bts=0,trx=1) ramping TRX board output power to -10000 mdBm. 20200702145125616 DTRX <000b> trx_if.c:247 phy0.1: Enqueuing TRX control command 'CMD SETPOWER 33' 20200702145125618 DTRX <000b> trx_if.c:641 phy0.0: Response message: 'RSP SETPOWER 0 33' 20200702145125619 DTRX <000b> trx_if.c:641 phy0.1: Response message: 'RSP SETPOWER 0 33' 20200702145127615 DOML <0001> fsm.c:322 BTS_SHUTDOWN(bts0)[0x6120000003a0]{WAIT_TRX_CLOSED}: Timeout of X2 20200702145127615 DOML <0001> bts_shutdown_fsm.c:176 BTS_SHUTDOWN(bts0)[0x6120000003a0]{WAIT_TRX_CLOSED}: Timer expired waiting for TRX close 20200702145127615 DOML <0001> bts_shutdown_fsm.c:177 BTS_SHUTDOWN(bts0)[0x6120000003a0]{WAIT_TRX_CLOSED}: state_chg to EXIT 20200702145127616 DOML <0001> bts_shutdown_fsm.c:125 BTS_SHUTDOWN(bts0)[0x6120000003a0]{EXIT}: Shutdown process completed successfuly, exiting process
Updated by pespin almost 4 years ago
So the only issue I can see here is that we are not speeding up shutdown if there's a ramping down in process and we receive RSP POWEROFF 0 (so it becomes clear ramping further down is going to do nothing).
I'll look into it soon.
Updated by pespin almost 4 years ago
- Status changed from New to Feedback
- Assignee changed from pespin to Hoernchen
- % Done changed from 0 to 90
Should be fixed by:
https://gerrit.osmocom.org/c/osmo-bts/+/19108 bts_shutdown: Speed up shutdown if no TRX is operational
Updated by pespin almost 4 years ago
Hoernchen please confirm it's fixed with that commit applied and then close the ticket.
Updated by fixeria over 3 years ago
- Status changed from Feedback to Resolved
- % Done changed from 90 to 100
I also faced this problem, and now I am happy to confirm that it has been fixed.