We read every piece of feedback, and take your input very seriously.
To see all available qualifiers, see our documentation.
Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.
By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.
Already on GitHub? Sign in to your account
Hi! I have a trouble with bladeRFx40 and YateBTS on Ubuntu 18.04. Yate works normally for a while but it stops working after a few minutes.
Versions info is shown below;
I run the following command;
$ sudo yate -vvv
The device successfully work and I can connect my phone to gsm but after a while, Yate turns itself off with "Segmentation Fault".
All Yate outputs are shown below;
Yate (19141) is starting Sat Aug 28 10:16:28 2021 2021-08-28_10:16:28.493763 <ALL> Plugin::Plugin("stun",false) [0x7f8f604383a0] Loaded module YSTUN 2021-08-28_10:16:28.494076 <ALL> Plugin::Plugin("yrtp",false) [0x7f8f6022e120] Loaded module YRTP 2021-08-28_10:16:28.494365 <ALL> Plugin::Plugin("extmodule",false) [0x7f8f60005960] Loaded module ExtModule 2021-08-28_10:16:28.495221 <ALL> Plugin::Plugin("jingle",false) [0x7f8f5fdefae0] Loaded module YJingle 2021-08-28_10:16:28.495363 <ALL> Plugin::Plugin("cdrcombine",false) [0x7f8f5f95c900] Loaded module CdrCombine 2021-08-28_10:16:28.496146 <ALL> Plugin::Plugin("javascript",true) [0x7f8f5f756460] Loaded module Javascript 2021-08-28_10:16:28.496264 <ALL> Plugin::Plugin("regexroute",false) [0x7f8f5f2c9300] Loaded module RegexRoute 2021-08-28_10:16:28.496367 <ALL> Plugin::Plugin("tone",false) [0x7f8f5f0b96c0] Loaded module ToneGen 2021-08-28_10:16:28.496382 <tone:ALL> Building comfort noise at level -10 2021-08-28_10:16:28.496457 <tone:ALL> Building tone of 1336 + 941 Hz 2021-08-28_10:16:28.496924 <tone:ALL> Building tone of 1209 + 697 Hz 2021-08-28_10:16:28.497360 <tone:ALL> Building tone of 1336 + 697 Hz 2021-08-28_10:16:28.497837 <tone:ALL> Building tone of 1477 + 697 Hz 2021-08-28_10:16:28.498315 <tone:ALL> Building tone of 1209 + 770 Hz 2021-08-28_10:16:28.498783 <tone:ALL> Building tone of 1336 + 770 Hz 2021-08-28_10:16:28.499263 <tone:ALL> Building tone of 1477 + 770 Hz 2021-08-28_10:16:28.499687 <tone:ALL> Building tone of 1209 + 852 Hz 2021-08-28_10:16:28.500081 <tone:ALL> Building tone of 1336 + 852 Hz 2021-08-28_10:16:28.500472 <tone:ALL> Building tone of 1477 + 852 Hz 2021-08-28_10:16:28.500893 <tone:ALL> Building tone of 1209 + 941 Hz 2021-08-28_10:16:28.501233 <tone:ALL> Building tone of 1477 + 941 Hz 2021-08-28_10:16:28.501584 <tone:ALL> Building tone of 1633 + 697 Hz 2021-08-28_10:16:28.501945 <tone:ALL> Building tone of 1633 + 770 Hz 2021-08-28_10:16:28.502314 <tone:ALL> Building tone of 1633 + 852 Hz 2021-08-28_10:16:28.502632 <tone:ALL> Building tone of 1633 + 941 Hz 2021-08-28_10:16:28.502946 <tone:ALL> Building tone of 2000 + 125 Hz 2021-08-28_10:16:28.503874 <tone:ALL> Building tone of 2000 modulated by 1000 Hz 2021-08-28_10:16:28.505013 <tone:ALL> Building tone of 2010 Hz 2021-08-28_10:16:28.505094 <tone:ALL> Building tone of 1780 Hz 2021-08-28_10:16:28.505496 <ALL> Plugin::Plugin("sip",false) [0x7f8f5eea7da0] Loaded module SIP Channel 2021-08-28_10:16:28.505614 <ALL> Plugin::Plugin("wiresniff",false) [0x7f8f5ec38240] Loaded module WireSniff 2021-08-28_10:16:28.505715 <ALL> Plugin::Plugin("conf",false) [0x7f8f5ea32480] Loaded module Conference 2021-08-28_10:16:28.505935 <ALL> Plugin::Plugin("iax",false) [0x7f8f5e8234c0] Loaded module YIAX 2021-08-28_10:16:28.506008 <ALL> Plugin::Plugin("cdrbuild",false) [0x7f8f5e5e7220] Loaded module CdrBuild 2021-08-28_10:16:28.506087 <ALL> Plugin::Plugin("mux",true) [0x7f8f5e3da600] Loaded module MUX 2021-08-28_10:16:28.506166 <ALL> Plugin::Plugin("socks",true) [0x7f8f5e1cf960] Loaded module YSOCKS 2021-08-28_10:16:28.506233 <ALL> Plugin::Plugin("tonedetect",false) [0x7f8f5dfb82e0] Loaded module ToneDetector 2021-08-28_10:16:28.506299 <ALL> Plugin::Plugin("fileinfo",false) [0x7f8f5ddafb20] Loaded module FileInfo 2021-08-28_10:16:28.506357 <ALL> Plugin::Plugin("cdrfile",true) [0x7f8f5dba4240] Loaded module CdrFile 2021-08-28_10:16:28.506421 <ALL> Plugin::Plugin("gvoice",false) [0x7f8f5d99f460] Loaded module GVoice 2021-08-28_10:16:28.506485 <ALL> Plugin::Plugin("dumb",false) [0x7f8f5d7992a0] Loaded module DumbChannel 2021-08-28_10:16:28.506549 <ALL> Plugin::Plugin("enumroute",false) [0x7f8f5d593300] 2021-08-28_10:16:28.506776 <ALL> Plugin::Plugin("isaccodec",false) [0x7f8f5d38b6e0] Loaded module iSAC floating point - based on WebRTC iSAC library version 4.3.0 (SPL version 1.2.0) 2021-08-28_10:16:28.506899 <ALL> Plugin::Plugin("zlibcompress",true) [0x7f8f5d150220] Loaded module ZLib - using zlib library version 1.2.11 2021-08-28_10:16:28.506969 <ALL> Plugin::Plugin("msgsniff",false) [0x7f8f5cd2c220] Loaded module MsgSniffer 2021-08-28_10:16:28.507061 <ALL> Plugin::Plugin("filetransfer",false) [0x7f8f5cb26820] Loaded module File Transfer 2021-08-28_10:16:28.507137 <ALL> Plugin::Plugin("g722webrtc",false) [0x7f8f5c916240] Loaded module G722 - based on WebRTC G.722 library version 2.0.0 2021-08-28_10:16:28.507227 <ALL> Plugin::Plugin("rmanager",false) [0x7f8f5c70e600] Loaded module RManager 2021-08-28_10:16:28.507308 <ALL> Plugin::Plugin("analyzer",false) [0x7f8f5c4fc420] Loaded module Analyzer 2021-08-28_10:16:28.507388 <ALL> Plugin::Plugin("moh",false) [0x7f8f5c2f1400] Loaded module MOH 2021-08-28_10:16:28.507461 <ALL> Plugin::Plugin("callgen",false) [0x7f8f5c0e8360] Loaded module Call Generator 2021-08-28_10:16:28.507518 <ALL> Plugin::Plugin("pbx",false) [0x7f8f5bedd480] Loaded module PBX 2021-08-28_10:16:28.507674 <ALL> Plugin::Plugin("ilbcwebrtc",false) [0x7f8f5bcd6580] Loaded module iLBC - based on WebRTC iLBC library version 1.1.1 2021-08-28_10:16:28.507792 <ALL> Plugin::Plugin("wave",false) [0x7f8f5babf9c0] Loaded module WaveFile 2021-08-28_10:16:28.508955 <ALL> Plugin::Plugin("openssl",true) [0x7f8f5b8af5a0] Loaded module OpenSSL - based on OpenSSL 1.1.1 11 Sep 2018 2021-08-28_10:16:28.509099 <ALL> Plugin::Plugin("ilbccodec",false) [0x7f8f5af4c000] Loaded module iLBC - based on iLBC reference library 2021-08-28_10:16:28.509177 <ALL> Plugin::Plugin("callfork",false) [0x7f8f5ad2b420] Loaded module Call Forker 2021-08-28_10:16:28.509288 <ALL> Plugin::Plugin("gsmcodec",false) [0x7f8f5ab20140] Loaded module GSM - based on libgsm-1.0.10 2021-08-28_10:16:28.509417 <ALL> Plugin::Plugin("sipfeatures",false) [0x7f8f5a70e380] Loaded module SIP Features 2021-08-28_10:16:28.509973 <ALL> Plugin::Plugin("snmpagent",false) [0x7f8f5a504f40] Loaded module SNMP Agent 2021-08-28_10:16:28.510063 <ALL> Plugin::Plugin("pbxassist",false) [0x7f8f5a0b93c0] 2021-08-28_10:16:28.510128 <ALL> Plugin::Plugin("park",false) [0x7f8f59ea9240] Loaded module Call Parking 2021-08-28_10:16:28.510199 <ALL> Plugin::Plugin("cache",false) [0x7f8f59ca3920] Loaded module Cache 2021-08-28_10:16:28.510262 <ALL> Plugin::Plugin("mrcp",false) [0x7f8f59a93280] Loaded module MRCP 2021-08-28_10:16:28.510319 <ALL> Plugin::Plugin("users",false) [0x7f8f5988b260] Loaded module Users Management 2021-08-28_10:16:28.510418 <ALL> Plugin::Plugin("analogdetect",true) [0x7f8f596849c0] Loaded module Analog Detector 2021-08-28_10:16:28.510530 <libyatemodem:INFO> Initialized filter tables for type 'etsi' headerlen=6400 2021-08-28_10:16:28.510579 <ALL> Plugin::Plugin("callcounters",false) [0x7f8f594751c0] Loaded module CallCounters 2021-08-28_10:16:28.510815 <ALL> Plugin::Plugin("mgcpgw",false) [0x7f8f5926f100] Loaded module MGCP-GW 2021-08-28_10:16:28.512329 <ALL> Plugin::Plugin("sig",false) [0x7f8f58e40140] Loaded module Signalling Channel 2021-08-28_10:16:28.512423 <ALL> Plugin::Plugin("monitoring",false) [0x7f8f588cc280] Loaded module Monitoring 2021-08-28_10:16:28.512529 <ALL> Plugin::Plugin("sigtransport",true) [0x7f8f586b0700] Loaded module SigTransport 2021-08-28_10:16:28.512585 <ALL> Plugin::Plugin("lateroute",false) [0x7f8f584a0240] Loaded module Late Router 2021-08-28_10:16:28.512752 <ALL> Plugin::Plugin("mgcpca",true) [0x7f8f5829b260] Loaded module MGCP-CA 2021-08-28_10:16:28.512819 <ALL> Plugin::Plugin("presence",false) [0x7f8f580732a0] Loaded module Presence 2021-08-28_10:16:28.513165 <ALL> Plugin::Plugin("ybts",false) [0x7f8f57e66b00] Loaded module YBTS 2021-08-28_10:16:28.513249 <ALL> Plugin::Plugin("queuesnotify",false) [0x7f8f579cd480] Loaded module Queues Notify 2021-08-28_10:16:28.513413 <ALL> Plugin::Plugin("sqlitedb",true) [0x7f8f577c4380] Loaded module SQLite based on 3.22.0 2021-08-28_10:16:28.513526 <ALL> Plugin::Plugin("register",false) [0x7f8f572b2600] Loaded module Register for database 2021-08-28_10:16:28.513625 <ALL> Plugin::Plugin("dbpbx",false) [0x7f8f570a4280] Loaded module PBX for database 2021-08-28_10:16:28.513686 <ALL> Plugin::Plugin("heartbeat",false) [0x7f8f56e9c260] Loaded module Heartbeat 2021-08-28_10:16:28.513787 <ALL> Plugin::Plugin("ciscosm",true) [0x7f8f56c96540] Loaded module Cisco SM 2021-08-28_10:16:28.513874 <ALL> Plugin::Plugin("accfile",false) [0x7f8f56a852e0] Loaded module Accounts from file 2021-08-28_10:16:28.513934 <ALL> Plugin::Plugin("clustering",true) [0x7f8f5687f1e0] Loaded module Clustering 2021-08-28_10:16:28.514054 <ALL> Plugin::Plugin("analog",false) [0x7f8f566796a0] Loaded module Analog Channel 2021-08-28_10:16:28.514133 <ALL> Plugin::Plugin("subscription",true) [0x7f8f564607a0] Loaded module Subscriptions 2021-08-28_10:16:28.514196 <ALL> Plugin::Plugin("queues",false) [0x7f8f5624c580] Loaded module Queues 2021-08-28_10:16:28.514605 <ALL> Plugin::Plugin("gsmtrx",false) [0x7f8f56041d00] Loaded module GSM Transceiver 2021-08-28_10:16:28.514672 <ALL> Plugin::Plugin("dbwave",true) [0x7f8f55e07260] Loaded module DbWave 2021-08-28_10:16:28.514745 <ALL> Plugin::Plugin("regfile",false) [0x7f8f55c01380] Loaded module Registration from file 2021-08-28_10:16:28.514828 <ALL> Plugin::Plugin("yradius",false) [0x7f8f559f8a40] Loaded module Radius client 2021-08-28_10:16:28.514887 <ALL> Plugin::Plugin("ccongestion",false) [0x7f8f557e72c0] Loaded module CCongestion 2021-08-28_10:16:28.514952 <ALL> Plugin::Plugin("cpuload",true) [0x7f8f555e13e0] Loaded module Cpu 2021-08-28_10:16:28.515068 <ALL> Plugin::Plugin("eventlogs",true) [0x7f8f553d82e0] Loaded module Event Logs 2021-08-28_10:16:28.515182 <ALL> Plugin::Plugin("jbfeatures",true) [0x7f8f551d3420] Loaded module Jabber Server Features 2021-08-28_10:16:28.515350 <ALL> Plugin::Plugin("jabber",true) [0x7f8f54fc6d20] Loaded module Jabber Server 2021-08-28_10:16:28.515465 <ALL> Plugin::Plugin("radiotest",false) [0x7f8f54d9bce0] Loaded module Radio Test 2021-08-28_10:16:28.515913 <ALL> Plugin::Plugin("bladerf",true) [0x7f8f54b8ada0] Loaded module BladeRF using libusb 1.0.21.11156 desc='http://libusb.info' 2021-08-28_10:16:28.516021 <ALL> Plugin::Plugin("dummyradio",true) [0x7f8f54099700] Loaded module DummyRadio 2021-08-28_10:16:28.516042 <ALL> Loaded 77 plugins Initializing plugins Initializing module DummyRadio Initializing module BladeRF Initializing module Jabber Server 2021-08-28_10:16:28.516229 <jabber:ALL> JBPendingWorker(0) start running [0x5645b7c20d60] 2021-08-28_10:16:28.516296 <jbserverengine:NOTE> Failed to load entity caps from '/usr/local/etc/yate/jabberentitycaps.xml': I/O error 2 'No such file or directory' 2021-08-28_10:16:28.516312 <jbserverengine:NOTE> No domains configured Initializing module Jabber Server Features Initializing module Event Logs Initializing module Cpu 2021-08-28_10:16:28.516610 <cpuload:NOTE> Updating CPU core number from 1 to 8 Initializing module DbWave Initializing module Subscriptions Initializing module Clustering Initializing module Cisco SM Initializing module SQLite Initializing module MGCP Call Agent 2021-08-28_10:16:28.516838 <mgcpca:ALL> No gateways defined so module not initialized. 2021-08-28_10:16:28.518174 <mgcpca:ALL> Initialized audio codecs: mulaw,alaw,gsm,slin,g722/16000,ilbc20,ilbc30,isac/16000,isac/32000 Initializing module SigTransport Initializing module Analog Detector Initializing module OpenSSL Initializing module ZLib 2021-08-28_10:16:28.519148 <zlibcompress:ALL> Initialized compressor_buflen=256 decompressor_buflen=1024 compress_level=default Initializing module CdrFile Initializing module YSOCKS 2021-08-28_10:16:28.519227 <socks:INFO> Initialized auth-timeout=10000ms reply-timeout=30000ms print-msg=false print-extended=false Initializing module MUX Initializing module Javascript 2021-08-28_10:16:28.521300 <javascript:INFO> Parsed 'eliza' script: /usr/local/share/yate/scripts/eliza.js Initializing module YSTUN 2021-08-28_10:16:28.521867 <stun:ALL> Bind request interval set to 15000 msec. Initializing module YRTP Initializing module ExtModule Initializing module YJingle 2021-08-28_10:16:28.522108 <jgengine:ALL> Jingle engine initialized: jingle_flags=0 stanza_timeout=20000 ping_interval=300000 [0x5645b7cf8530] 2021-08-28_10:16:28.522121 <jingle:ALL> YJGEngineWorker start running Initializing module CdrCombine Initializing module RegexRoute Initializing module ToneGen 2021-08-28_10:16:28.522628 <tone:ALL> ToneDesc(at/dial) initializing from '420' [0x5645b7d100f0] 2021-08-28_10:16:28.522641 <tone:ALL> Building tone of 420 Hz 2021-08-28_10:16:28.522728 <tone:ALL> ToneDesc(at/busy) initializing from '420/400,0/400' [0x5645b7cfe540] 2021-08-28_10:16:28.522735 <tone:ALL> ToneDesc(at/ring) initializing from '420/1000,0/5000' [0x5645b7cfe750] 2021-08-28_10:16:28.522741 <tone:ALL> ToneDesc(at/congestion) initializing from '420/200,0/200' [0x5645b7cfe8f0] 2021-08-28_10:16:28.522747 <tone:ALL> ToneDesc(at/callwaiting) initializing from '420/40,0/1960' [0x5645b7cfeb10] 2021-08-28_10:16:28.522754 <tone:ALL> ToneDesc(at/dialrecall) initializing from '420' [0x5645b7cfed30] 2021-08-28_10:16:28.522759 <tone:ALL> ToneDesc(at/record) initializing from '1400/80,0/14920' [0x5645b7cfee90] 2021-08-28_10:16:28.522764 <tone:ALL> Building tone of 1400 Hz 2021-08-28_10:16:28.522877 <tone:ALL> ToneDesc(at/info) initializing from '950/330,1450/330,1850/330,0/1000' [0x5645b7cff230] 2021-08-28_10:16:28.522883 <tone:ALL> Building tone of 950 Hz 2021-08-28_10:16:28.522969 <tone:ALL> Building tone of 1450 Hz 2021-08-28_10:16:28.523057 <tone:ALL> Building tone of 1850 Hz 2021-08-28_10:16:28.523146 <tone:ALL> ToneDesc(at/stutter) initializing from '380+420' [0x5645b7d1f080] 2021-08-28_10:16:28.523151 <tone:ALL> Building tone of 420 + 380 Hz 2021-08-28_10:16:28.523503 <tone:ALL> ToneDesc(au/dial) initializing from '413+438' [0x5645b7d23100] 2021-08-28_10:16:28.523509 <tone:ALL> Building tone of 438 + 413 Hz 2021-08-28_10:16:28.523869 <tone:ALL> ToneDesc(au/busy) initializing from '425/375,0/375' [0x5645b7d27240] 2021-08-28_10:16:28.523876 <tone:ALL> Building tone of 425 Hz 2021-08-28_10:16:28.524048 <tone:ALL> ToneDesc(au/ring) initializing from '413+438/400,0/200,413+438/400,0/2000' [0x5645b7d2b490] 2021-08-28_10:16:28.524058 <tone:ALL> ToneDesc(au/congestion) initializing from '425/375,0/375,420/375,0/375' [0x5645b7d2b760] 2021-08-28_10:16:28.524072 <tone:ALL> ToneDesc(au/callwaiting) initializing from '425/200,0/200,425/200,0/4400' [0x5645b7d2b9c0] 2021-08-28_10:16:28.524083 <tone:ALL> ToneDesc(au/dialrecall) initializing from '413+438' [0x5645b7d2bc20] 2021-08-28_10:16:28.524091 <tone:ALL> ToneDesc(au/record) initializing from '!425/1000,!0/15000,425/360,0/15000' [0x5645b7d2bd90] 2021-08-28_10:16:28.524103 <tone:ALL> ToneDesc(au/info) initializing from '425/2500,0/500' [0x5645b7d2c050] 2021-08-28_10:16:28.524111 <tone:ALL> ToneDesc(au/std) initializing from '!525/100,!0/100,!525/100,!0/100,!525/100,!0/100,!525/100,!0/100,!525/100' [0x5645b7d2c1d0] 2021-08-28_10:16:28.524118 <tone:ALL> Building tone of 525 Hz 2021-08-28_10:16:28.524341 <tone:ALL> ToneDesc(au/facility) initializing from '425' [0x5645b7d305d0] 2021-08-28_10:16:28.524348 <tone:ALL> ToneDesc(au/stutter) initializing from '413+438/100,0/40' [0x5645b7d30730] 2021-08-28_10:16:28.524356 <tone:ALL> ToneDesc(au/ringmobile) initializing from '400+450/400,0/200,400+450/400,0/2000' [0x5645b7d308b0] 2021-08-28_10:16:28.524362 <tone:ALL> Building tone of 450 + 400 Hz 2021-08-28_10:16:28.524919 <tone:ALL> ToneDesc(bg/dial) initializing from '425' [0x5645b7d34990] 2021-08-28_10:16:28.524926 <tone:ALL> ToneDesc(bg/busy) initializing from '425/500,0/500' [0x5645b7d34af0] 2021-08-28_10:16:28.524932 <tone:ALL> ToneDesc(bg/ring) initializing from '425/1000,0/4000' [0x5645b7d34c70] 2021-08-28_10:16:28.524939 <tone:ALL> ToneDesc(bg/congestion) initializing from '425/250,0/250' [0x5645b7d34e60] 2021-08-28_10:16:28.524949 <tone:ALL> ToneDesc(bg/callwaiting) initializing from '425/150,0/150,425/150,0/4000' [0x5645b7d35080] 2021-08-28_10:16:28.524957 <tone:ALL> ToneDesc(bg/dialrecall) initializing from '!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,425' [0x5645b7d353e0] 2021-08-28_10:16:28.524967 <tone:ALL> ToneDesc(bg/record) initializing from '1400/425,0/15000' [0x5645b7d35760] 2021-08-28_10:16:28.524974 <tone:ALL> ToneDesc(bg/info) initializing from '950/330,1400/330,1800/330,0/1000' [0x5645b7d358e0] 2021-08-28_10:16:28.524981 <tone:ALL> Building tone of 1800 Hz 2021-08-28_10:16:28.525120 <tone:ALL> ToneDesc(bg/stutter) initializing from '425/1500,0/100' [0x5645b7d37ab0] 2021-08-28_10:16:28.525130 <tone:ALL> ToneDesc(br/dial) initializing from '425' [0x5645b7d37c30] 2021-08-28_10:16:28.525136 <tone:ALL> ToneDesc(br/busy) initializing from '425/250,0/250' [0x5645b7d37d90] 2021-08-28_10:16:28.525145 <tone:ALL> ToneDesc(br/ring) initializing from '425/1000,0/4000' [0x5645b7d37fd0] 2021-08-28_10:16:28.525152 <tone:ALL> ToneDesc(br/congestion) initializing from '425/250,0/250,425/750,0/250' [0x5645b7d381f0] 2021-08-28_10:16:28.525161 <tone:ALL> ToneDesc(br/callwaiting) initializing from '425/50,0/1000' [0x5645b7d38550] 2021-08-28_10:16:28.525168 <tone:ALL> ToneDesc(br/dialrecall) initializing from '350+440' [0x5645b7d386d0] 2021-08-28_10:16:28.525174 <tone:ALL> Building tone of 440 + 350 Hz 2021-08-28_10:16:28.525619 <tone:ALL> ToneDesc(br/record) initializing from '425/250,0/250' [0x5645b7d3c790] 2021-08-28_10:16:28.525627 <tone:ALL> ToneDesc(br/info) initializing from '950/330,1400/330,1800/330' [0x5645b7d3ca10] 2021-08-28_10:16:28.525635 <tone:ALL> ToneDesc(br/stutter) initializing from '350+440' [0x5645b7d3ccd0] 2021-08-28_10:16:28.525643 <tone:ALL> ToneDesc(be/dial) initializing from '425' [0x5645b7d3ce30] 2021-08-28_10:16:28.525650 <tone:ALL> ToneDesc(be/busy) initializing from '425/500,0/500' [0x5645b7d3cf90] 2021-08-28_10:16:28.525666 <tone:ALL> ToneDesc(be/ring) initializing from '425/1000,0/3000' [0x5645b7d3d250] 2021-08-28_10:16:28.525673 <tone:ALL> ToneDesc(be/congestion) initializing from '425/167,0/167' [0x5645b7d3d470] 2021-08-28_10:16:28.525680 <tone:ALL> ToneDesc(be/callwaiting) initializing from '1400/175,0/175,1400/175,0/3500' [0x5645b7d3d690] 2021-08-28_10:16:28.525689 <tone:ALL> ToneDesc(be/dialrecall) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440"' [0x5645b7d3d9f0] 2021-08-28_10:16:28.525700 <tone:ALL> ToneDesc(be/record) initializing from '1400/500,0/15000' [0x5645b7d3de20] 2021-08-28_10:16:28.525710 <tone:ALL> ToneDesc(be/info) initializing from '900/330,1400/330,1800/330,0/1000' [0x5645b7d3dfa0] 2021-08-28_10:16:28.525716 <tone:ALL> Building tone of 900 Hz 2021-08-28_10:16:28.525841 <tone:ALL> ToneDesc(be/stutter) initializing from '425/1000,0/250' [0x5645b7d40170] 2021-08-28_10:16:28.525849 <tone:ALL> ToneDesc(ch/dial) initializing from '425' [0x5645b7d402f0] 2021-08-28_10:16:28.525855 <tone:ALL> ToneDesc(ch/busy) initializing from '425/500,0/500' [0x5645b7d40450] 2021-08-28_10:16:28.525862 <tone:ALL> ToneDesc(ch/ring) initializing from '425/1000,0/4000' [0x5645b7d40690] 2021-08-28_10:16:28.525869 <tone:ALL> ToneDesc(ch/congestion) initializing from '425/200,0/200' [0x5645b7d408b0] 2021-08-28_10:16:28.525876 <tone:ALL> ToneDesc(ch/callwaiting) initializing from '425/200,0/200,425/200,0/4000' [0x5645b7d40ad0] 2021-08-28_10:16:28.525884 <tone:ALL> ToneDesc(ch/dialrecall) initializing from '!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,425' [0x5645b7d40e30] 2021-08-28_10:16:28.525897 <tone:ALL> ToneDesc(ch/record) initializing from '1400/80,0/15000' [0x5645b7d41250] 2021-08-28_10:16:28.525904 <tone:ALL> ToneDesc(ch/info) initializing from '950/330,1400/330,1800/330,0/1000' [0x5645b7d413d0] 2021-08-28_10:16:28.525912 <tone:ALL> ToneDesc(ch/stutter) initializing from '425+340/1100,0/1100' [0x5645b7d41590] 2021-08-28_10:16:28.525918 <tone:ALL> Building tone of 425 + 340 Hz 2021-08-28_10:16:28.526332 <tone:ALL> ToneDesc(cl/dial) initializing from '400' [0x5645b7d45630] 2021-08-28_10:16:28.526337 <tone:ALL> Building tone of 400 Hz 2021-08-28_10:16:28.526503 <tone:ALL> ToneDesc(cl/busy) initializing from '400/500,0/500' [0x5645b7d477d0] 2021-08-28_10:16:28.526511 <tone:ALL> ToneDesc(cl/ring) initializing from '400/1000,0/3000' [0x5645b7d47a70] 2021-08-28_10:16:28.526518 <tone:ALL> ToneDesc(cl/congestion) initializing from '400/200,0/200' [0x5645b7d47c90] 2021-08-28_10:16:28.526525 <tone:ALL> ToneDesc(cl/callwaiting) initializing from '400/250,0/8750' [0x5645b7d47eb0] 2021-08-28_10:16:28.526533 <tone:ALL> ToneDesc(cl/dialrecall) initializing from '!400/100,!0/100,!400/100,!0/100,!400/100,!0/100,400' [0x5645b7d480d0] 2021-08-28_10:16:28.526543 <tone:ALL> ToneDesc(cl/record) initializing from '1400/500,0/15000' [0x5645b7d485f0] 2021-08-28_10:16:28.526551 <tone:ALL> ToneDesc(cl/info) initializing from '950/333,1400/333,1800/333,0/1000' [0x5645b7d48770] 2021-08-28_10:16:28.526558 <tone:ALL> ToneDesc(cl/stutter) initializing from '!400/100,!0/100,!400/100,!0/100,!400/100,!0/100,!400/100,!0/100,!400/100,!0/100,!400/100,!0/100,400' [0x5645b7d48930] 2021-08-28_10:16:28.526575 <tone:ALL> ToneDesc(cn/dial) initializing from '450' [0x5645b7d490b0] 2021-08-28_10:16:28.526581 <tone:ALL> Building tone of 450 Hz 2021-08-28_10:16:28.526695 <tone:ALL> ToneDesc(cn/busy) initializing from '450/350,0/350' [0x5645b7d48b10] 2021-08-28_10:16:28.526704 <tone:ALL> ToneDesc(cn/ring) initializing from '450/1000,0/4000' [0x5645b7d48cc0] 2021-08-28_10:16:28.526712 <tone:ALL> ToneDesc(cn/congestion) initializing from '450/700,0/700' [0x5645b7d4b210] 2021-08-28_10:16:28.526719 <tone:ALL> ToneDesc(cn/callwaiting) initializing from '450/400,0/4000' [0x5645b7d4b400] 2021-08-28_10:16:28.526726 <tone:ALL> ToneDesc(cn/dialrecall) initializing from '450' [0x5645b7d4b620] 2021-08-28_10:16:28.526732 <tone:ALL> ToneDesc(cn/record) initializing from '950/400,0/10000' [0x5645b7d4b780] 2021-08-28_10:16:28.526740 <tone:ALL> ToneDesc(cn/info) initializing from '450/100,0/100,450/100,0/100,450/100,0/100,450/400,0/400' [0x5645b7d4ba00] 2021-08-28_10:16:28.526751 <tone:ALL> ToneDesc(cn/stutter) initializing from '450+425' [0x5645b7d4bef0] 2021-08-28_10:16:28.526758 <tone:ALL> Building tone of 450 + 425 Hz 2021-08-28_10:16:28.527194 <tone:ALL> ToneDesc(cz/dial) initializing from '425/330,0/330,425/660,0/660' [0x5645b7d4bd10] 2021-08-28_10:16:28.527205 <tone:ALL> ToneDesc(cz/busy) initializing from '425/330,0/330' [0x5645b7d500f0] 2021-08-28_10:16:28.527214 <tone:ALL> ToneDesc(cz/ring) initializing from '425/1000,0/4000' [0x5645b7d50230] 2021-08-28_10:16:28.527222 <tone:ALL> ToneDesc(cz/congestion) initializing from '425/165,0/165' [0x5645b7d50420] 2021-08-28_10:16:28.527229 <tone:ALL> ToneDesc(cz/callwaiting) initializing from '425/330,0/9000' [0x5645b7d50640] 2021-08-28_10:16:28.527236 <tone:ALL> ToneDesc(cz/dialrecall) initializing from '!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,425/330,0/330,425/660,0/660' [0x5645b7d50860] 2021-08-28_10:16:28.527249 <tone:ALL> ToneDesc(cz/record) initializing from '1400/500,0/14000' [0x5645b7d50ea0] 2021-08-28_10:16:28.527256 <tone:ALL> ToneDesc(cz/info) initializing from '950/330,0/30,1400/330,0/30,1800/330,0/1000' [0x5645b7d50ab0] 2021-08-28_10:16:28.527270 <tone:ALL> ToneDesc(cz/stutter) initializing from '425/450,0/50' [0x5645b7d51130] 2021-08-28_10:16:28.527279 <tone:ALL> ToneDesc(de/dial) initializing from '425' [0x5645b7d512b0] 2021-08-28_10:16:28.527286 <tone:ALL> ToneDesc(de/busy) initializing from '425/480,0/480' [0x5645b7d51410] 2021-08-28_10:16:28.527293 <tone:ALL> ToneDesc(de/ring) initializing from '425/1000,0/4000' [0x5645b7d515b0] 2021-08-28_10:16:28.527301 <tone:ALL> ToneDesc(de/congestion) initializing from '425/240,0/240' [0x5645b7d51770] 2021-08-28_10:16:28.527308 <tone:ALL> ToneDesc(de/callwaiting) initializing from '!425/200,!0/200,!425/200,!0/5000,!425/200,!0/200,!425/200,!0/5000,!425/200,!0/200,!425/200,!0/5000,!425/200,!0/200,!425/200,!0/5000,!425/200,!0/200,!425/200,0' [0x5645b7d51990] 2021-08-28_10:16:28.527327 <tone:ALL> ToneDesc(de/dialrecall) initializing from '!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,425' [0x5645b7d526f0] 2021-08-28_10:16:28.527338 <tone:ALL> ToneDesc(de/record) initializing from '1400/80,0/15000' [0x5645b7d52910] 2021-08-28_10:16:28.527346 <tone:ALL> ToneDesc(de/info) initializing from '950/330,1400/330,1800/330,0/1000' [0x5645b7d52a90] 2021-08-28_10:16:28.527357 <tone:ALL> ToneDesc(de/stutter) initializing from '425+400' [0x5645b7d52c50] 2021-08-28_10:16:28.527363 <tone:ALL> Building tone of 425 + 400 Hz 2021-08-28_10:16:28.527939 <tone:ALL> ToneDesc(dk/dial) initializing from '425' [0x5645b7d52390] 2021-08-28_10:16:28.527952 <tone:ALL> ToneDesc(dk/busy) initializing from '425/500,0/500' [0x5645b7d51d10] 2021-08-28_10:16:28.527962 <tone:ALL> ToneDesc(dk/ring) initializing from '425/1000,0/4000' [0x5645b7d51f10] 2021-08-28_10:16:28.527970 <tone:ALL> ToneDesc(dk/congestion) initializing from '425/200,0/200' [0x5645b7d56d10] 2021-08-28_10:16:28.527978 <tone:ALL> ToneDesc(dk/callwaiting) initializing from '!425/200,!0/600,!425/200,!0/3000,!425/200,!0/200,!425/200,0' [0x5645b7d56f30] 2021-08-28_10:16:28.527992 <tone:ALL> ToneDesc(dk/dialrecall) initializing from '!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,425' [0x5645b7d57430] 2021-08-28_10:16:28.528002 <tone:ALL> ToneDesc(dk/record) initializing from '1400/80,0/15000' [0x5645b7d57650] 2021-08-28_10:16:28.528009 <tone:ALL> ToneDesc(dk/info) initializing from '950/330,1400/330,1800/330,0/1000' [0x5645b7d577d0] 2021-08-28_10:16:28.528018 <tone:ALL> ToneDesc(dk/stutter) initializing from '425/450,0/50' [0x5645b7d57990] 2021-08-28_10:16:28.528028 <tone:ALL> ToneDesc(ee/dial) initializing from '425' [0x5645b7d57b10] 2021-08-28_10:16:28.528036 <tone:ALL> ToneDesc(ee/busy) initializing from '425/300,0/300' [0x5645b7d57c70] 2021-08-28_10:16:28.528044 <tone:ALL> ToneDesc(ee/ring) initializing from '425/1000,0/4000' [0x5645b7d57e50] 2021-08-28_10:16:28.528054 <tone:ALL> ToneDesc(ee/congestion) initializing from '425/200,0/200' [0x5645b7d58070] 2021-08-28_10:16:28.528063 <tone:ALL> ToneDesc(ee/callwaiting) initializing from '950/650,0/325,950/325,0/30,1400/1300,0/2600' [0x5645b7d58290] 2021-08-28_10:16:28.528074 <tone:ALL> ToneDesc(ee/dialrecall) initializing from '425/650,0/25' [0x5645b7d58730] 2021-08-28_10:16:28.528082 <tone:ALL> ToneDesc(ee/record) initializing from '1400/500,0/15000' [0x5645b7d588b0] 2021-08-28_10:16:28.528091 <tone:ALL> ToneDesc(ee/info) initializing from '950/650,0/325,950/325,0/30,1400/1300,0/2600' [0x5645b7d58a30] 2021-08-28_10:16:28.528101 <tone:ALL> ToneDesc(ee/stutter) initializing from '!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,425' [0x5645b7d58dd0] 2021-08-28_10:16:28.528121 <tone:ALL> ToneDesc(es/dial) initializing from '425' [0x5645b7d594b0] 2021-08-28_10:16:28.528129 <tone:ALL> ToneDesc(es/busy) initializing from '425/200,0/200' [0x5645b7d59610] 2021-08-28_10:16:28.528137 <tone:ALL> ToneDesc(es/ring) initializing from '425/1500,0/3000' [0x5645b7d59790] 2021-08-28_10:16:28.528145 <tone:ALL> ToneDesc(es/congestion) initializing from '425/200,0/200,425/200,0/200,425/200,0/600' [0x5645b7d59910] 2021-08-28_10:16:28.528155 <tone:ALL> ToneDesc(es/callwaiting) initializing from '425/175,0/175,425/175,0/3500' [0x5645b7d59b30] 2021-08-28_10:16:28.528165 <tone:ALL> ToneDesc(es/dialrecall) initializing from '!425/200,!0/200,!425/200,!0/200,!425/200,!0/200,425' [0x5645b7d59cf0] 2021-08-28_10:16:28.528176 <tone:ALL> ToneDesc(es/record) initializing from '1400/500,0/15000' [0x5645b7d59f90] 2021-08-28_10:16:28.528186 <tone:ALL> ToneDesc(es/info) initializing from '950/330,0/1000' [0x5645b7d5a110] 2021-08-28_10:16:28.528194 <tone:ALL> ToneDesc(es/dialout) initializing from '500' [0x5645b7d5a290] 2021-08-28_10:16:28.528201 <tone:ALL> Building tone of 500 Hz 2021-08-28_10:16:28.528388 <tone:ALL> ToneDesc(fi/dial) initializing from '425' [0x5645b7d5c3d0] 2021-08-28_10:16:28.528397 <tone:ALL> ToneDesc(fi/busy) initializing from '425/300,0/300' [0x5645b7d5c530] 2021-08-28_10:16:28.528405 <tone:ALL> ToneDesc(fi/ring) initializing from '425/1000,0/4000' [0x5645b7d5c7a0] 2021-08-28_10:16:28.528414 <tone:ALL> ToneDesc(fi/congestion) initializing from '425/200,0/200' [0x5645b7d5c9c0] 2021-08-28_10:16:28.528423 <tone:ALL> ToneDesc(fi/callwaiting) initializing from '425/150,0/150,425/150,0/8000' [0x5645b7d5cbe0] 2021-08-28_10:16:28.528432 <tone:ALL> ToneDesc(fi/dialrecall) initializing from '425/650,0/25' [0x5645b7d5cf40] 2021-08-28_10:16:28.528443 <tone:ALL> ToneDesc(fi/record) initializing from '1400/500,0/15000' [0x5645b7d5d0c0] 2021-08-28_10:16:28.528451 <tone:ALL> ToneDesc(fi/info) initializing from '950/650,0/325,950/325,0/30,1400/1300,0/2600' [0x5645b7d5d240] 2021-08-28_10:16:28.528462 <tone:ALL> ToneDesc(fi/stutter) initializing from '425/650,0/25' [0x5645b7d5d6e0] 2021-08-28_10:16:28.528472 <tone:ALL> ToneDesc(fr/dial) initializing from '440' [0x5645b7d5d860] 2021-08-28_10:16:28.528479 <tone:ALL> Building tone of 440 Hz 2021-08-28_10:16:28.528591 <tone:ALL> ToneDesc(fr/busy) initializing from '440/500,0/500' [0x5645b7d5f9a0] 2021-08-28_10:16:28.528601 <tone:ALL> ToneDesc(fr/ring) initializing from '440/1500,0/3500' [0x5645b7d5fb70] 2021-08-28_10:16:28.528609 <tone:ALL> ToneDesc(fr/congestion) initializing from '440/250,0/250' [0x5645b7d5fd90] 2021-08-28_10:16:28.528619 <tone:ALL> ToneDesc(fr/callwait) initializing from '440/300,0/10000' [0x5645b7d5ffb0] 2021-08-28_10:16:28.528628 <tone:ALL> ToneDesc(fr/dialrecall) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440' [0x5645b7d601b0] 2021-08-28_10:16:28.528641 <tone:ALL> ToneDesc(fr/record) initializing from '1400/500,0/15000' [0x5645b7d606e0] 2021-08-28_10:16:28.528649 <tone:ALL> ToneDesc(fr/info) initializing from '!950/330,!1400/330,!1800/330' [0x5645b7d60860] 2021-08-28_10:16:28.528659 <tone:ALL> ToneDesc(fr/stutter) initializing from '!440/100,!0/100,!440/100,!0/100,!440/100,!0/100,!440/100,!0/100,!440/100,!0/100,!440/100,!0/100,440' [0x5645b7d60a10] 2021-08-28_10:16:28.528678 <tone:ALL> ToneDesc(gr/dial) initializing from '425/200,0/300,425/700,0/800' [0x5645b7d61190] 2021-08-28_10:16:28.528688 <tone:ALL> ToneDesc(gr/busy) initializing from '425/300,0/300' [0x5645b7d61350] 2021-08-28_10:16:28.528697 <tone:ALL> ToneDesc(gr/ring) initializing from '425/1000,0/4000' [0x5645b7d614d0] 2021-08-28_10:16:28.528706 <tone:ALL> ToneDesc(gr/congestion) initializing from '425/200,0/200' [0x5645b7d61650] 2021-08-28_10:16:28.528715 <tone:ALL> ToneDesc(gr/callwaiting) initializing from '425/150,0/150,425/150,0/8000' [0x5645b7d617d0] 2021-08-28_10:16:28.528725 <tone:ALL> ToneDesc(gr/dialrecall) initializing from '425/650,0/25' [0x5645b7d619b0] 2021-08-28_10:16:28.528733 <tone:ALL> ToneDesc(gr/record) initializing from '1400/400,0/15000' [0x5645b7d61b30] 2021-08-28_10:16:28.528742 <tone:ALL> ToneDesc(gr/info) initializing from '!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000,0' [0x5645b7d61cb0] 2021-08-28_10:16:28.528760 <tone:ALL> ToneDesc(gr/stutter) initializing from '425/650,0/25' [0x5645b7d62360] 2021-08-28_10:16:28.528771 <tone:ALL> ToneDesc(hu/dial) initializing from '425' [0x5645b7d624e0] 2021-08-28_10:16:28.528779 <tone:ALL> ToneDesc(hu/busy) initializing from '425/300,0/300' [0x5645b7d62640] 2021-08-28_10:16:28.528788 <tone:ALL> ToneDesc(hu/ring) initializing from '425/1250,0/3750' [0x5645b7d627c0] 2021-08-28_10:16:28.528797 <tone:ALL> ToneDesc(hu/congestion) initializing from '425/300,0/300' [0x5645b7d62940] 2021-08-28_10:16:28.528806 <tone:ALL> ToneDesc(hu/callwaiting) initializing from '425/40,0/1960' [0x5645b7d62ac0] 2021-08-28_10:16:28.528814 <tone:ALL> ToneDesc(hu/dialrecall) initializing from '425+450' [0x5645b7d62c40] 2021-08-28_10:16:28.528823 <tone:ALL> ToneDesc(hu/record) initializing from '1400/400,0/15000' [0x5645b7d62db0] 2021-08-28_10:16:28.528832 <tone:ALL> ToneDesc(hu/info) initializing from '!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000,0' [0x5645b7d62f70] 2021-08-28_10:16:28.528849 <tone:ALL> ToneDesc(hu/stutter) initializing from '350+375+400' [0x5645b7d63680] 2021-08-28_10:16:28.528856 <tone:ALL> Building tone of 375 + 350 Hz 2021-08-28_10:16:28.529326 <tone:ALL> ToneDesc(il/dial) initializing from '414' [0x5645b7d630c0] 2021-08-28_10:16:28.529333 <tone:ALL> Building tone of 414 Hz 2021-08-28_10:16:28.529440 <tone:ALL> ToneDesc(il/busy) initializing from '414/500,0/500' [0x5645b7d632f0] 2021-08-28_10:16:28.529450 <tone:ALL> ToneDesc(il/ring) initializing from '414/1000,0/3000' [0x5645b7d69740] 2021-08-28_10:16:28.529459 <tone:ALL> ToneDesc(il/congestion) initializing from '414/250,0/250' [0x5645b7d69950] 2021-08-28_10:16:28.529468 <tone:ALL> ToneDesc(il/callwaiting) initializing from '414/100,0/100,414/100,0/100,414/600,0/3000' [0x5645b7d69b70] 2021-08-28_10:16:28.529482 <tone:ALL> ToneDesc(il/dialrecall) initializing from '!414/100,!0/100,!414/100,!0/100,!414/100,!0/100,414' [0x5645b7d6a010] 2021-08-28_10:16:28.529495 <tone:ALL> ToneDesc(il/record) initializing from '1400/500,0/15000' [0x5645b7d6a330] 2021-08-28_10:16:28.529504 <tone:ALL> ToneDesc(il/info) initializing from '1000/330,1400/330,1800/330,0/1000' [0x5645b7d6a4b0] 2021-08-28_10:16:28.529511 <tone:ALL> Building tone of 1000 Hz 2021-08-28_10:16:28.529775 <tone:ALL> ToneDesc(il/stutter) initializing from '!414/160,!0/160,!414/160,!0/160,!414/160,!0/160,!414/160,!0/160,!414/160,!0/160,!414/160,!0/160,!414/160,!0/160,!414/160,!0/160,!414/160,!0/160,!414/160,!0/160,414' [0x5645b7d6c680] 2021-08-28_10:16:28.529800 <tone:ALL> ToneDesc(in/dial) initializing from '400*25' [0x5645b7d6d360] 2021-08-28_10:16:28.529807 <tone:ALL> Building tone of 400 modulated by 25 Hz 2021-08-28_10:16:28.530355 <tone:ALL> ToneDesc(in/busy) initializing from '400/750,0/750' [0x5645b7d6c900] 2021-08-28_10:16:28.530365 <tone:ALL> ToneDesc(in/ring) initializing from '400*25/400,0/200,400*25/400,0/2000' [0x5645b7d6cab0] 2021-08-28_10:16:28.530376 <tone:ALL> ToneDesc(in/congestion) initializing from '400/250,0/250' [0x5645b7d6ce10] 2021-08-28_10:16:28.530386 <tone:ALL> ToneDesc(in/callwaiting) initializing from '400/200,0/100,400/200,0/7500' [0x5645b7d6cf90] 2021-08-28_10:16:28.530397 <tone:ALL> ToneDesc(in/dialrecall) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440' [0x5645b7d715b0] 2021-08-28_10:16:28.530411 <tone:ALL> ToneDesc(in/record) initializing from '1400/500,0/15000' [0x5645b7d719e0] 2021-08-28_10:16:28.530421 <tone:ALL> ToneDesc(in/info) initializing from '!950/330,!1400/330,!1800/330,0/1000' [0x5645b7d71b60] 2021-08-28_10:16:28.530432 <tone:ALL> ToneDesc(in/stutter) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440' [0x5645b7d71d20] 2021-08-28_10:16:28.530455 <tone:ALL> ToneDesc(it/dial) initializing from '425/200,0/200,425/600,0/1000' [0x5645b7d724c0] 2021-08-28_10:16:28.530467 <tone:ALL> ToneDesc(it/busy) initializing from '425/500,0/500' [0x5645b7d72680] 2021-08-28_10:16:28.530476 <tone:ALL> ToneDesc(it/ring) initializing from '425/1000,0/4000' [0x5645b7d72800] 2021-08-28_10:16:28.530485 <tone:ALL> ToneDesc(it/congestion) initializing from '425/200,0/200' [0x5645b7d72980] 2021-08-28_10:16:28.530495 <tone:ALL> ToneDesc(it/callwaiting) initializing from '425/400,0/100,425/250,0/100,425/150,0/14000' [0x5645b7d72b00] 2021-08-28_10:16:28.530507 <tone:ALL> ToneDesc(it/dialrecall) initializing from '470/400,425/400' [0x5645b7d72d60] 2021-08-28_10:16:28.530514 <tone:ALL> Building tone of 470 Hz 2021-08-28_10:16:28.530622 <tone:ALL> ToneDesc(it/record) initializing from '1400/400,0/15000' [0x5645b7d74ec0] 2021-08-28_10:16:28.530634 <tone:ALL> ToneDesc(it/info) initializing from '!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000,0' [0x5645b7d75040] 2021-08-28_10:16:28.530650 <tone:ALL> ToneDesc(it/stutter) initializing from '470/400,425/400' [0x5645b7d75740] 2021-08-28_10:16:28.530662 <tone:ALL> ToneDesc(lt/dial) initializing from '425' [0x5645b7d758c0] 2021-08-28_10:16:28.530671 <tone:ALL> ToneDesc(lt/busy) initializing from '425/350,0/350' [0x5645b7d75a20] 2021-08-28_10:16:28.530680 <tone:ALL> ToneDesc(lt/ring) initializing from '425/1000,0/4000' [0x5645b7d75ba0] 2021-08-28_10:16:28.530689 <tone:ALL> ToneDesc(lt/congestion) initializing from '425/200,0/200' [0x5645b7d75d20] 2021-08-28_10:16:28.530699 <tone:ALL> ToneDesc(lt/callwaiting) initializing from '425/150,0/150,425/150,0/4000' [0x5645b7d75ea0] 2021-08-28_10:16:28.530711 <tone:ALL> ToneDesc(lt/dialrecall) initializing from '425/500,0/50' [0x5645b7d760a0] 2021-08-28_10:16:28.530720 <tone:ALL> ToneDesc(lt/record) initializing from '1400/500,0/15000' [0x5645b7d76220] 2021-08-28_10:16:28.530730 <tone:ALL> ToneDesc(lt/info) initializing from '!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000,0' [0x5645b7d763a0] 2021-08-28_10:16:28.530747 <tone:ALL> ToneDesc(lt/stutter) initializing from '!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,425' [0x5645b7d76b90] 2021-08-28_10:16:28.530765 <tone:ALL> ToneDesc(jp/dial) initializing from '400' [0x5645b7d76ef0] 2021-08-28_10:16:28.530776 <tone:ALL> ToneDesc(jp/busy) initializing from '400/500,0/500' [0x5645b7d77050] 2021-08-28_10:16:28.530785 <tone:ALL> ToneDesc(jp/ring) initializing from '400+15/1000,0/2000' [0x5645b7d771d0] 2021-08-28_10:16:28.530792 <tone:ALL> Building tone of 400 + 15 Hz 2021-08-28_10:16:28.531329 <tone:ALL> ToneDesc(jp/congestion) initializing from '400/500,0/500' [0x5645b7d7b270] 2021-08-28_10:16:28.531340 <tone:ALL> ToneDesc(jp/callwaiting) initializing from '400+16/500,0/8000' [0x5645b7d7b360] 2021-08-28_10:16:28.531348 <tone:ALL> Building tone of 400 + 16 Hz 2021-08-28_10:16:28.531897 <tone:ALL> ToneDesc(jp/dialrecall) initializing from '!400/200,!0/200,!400/200,!0/200,!400/200,!0/200,400' [0x5645b7d7f3c0] 2021-08-28_10:16:28.531913 <tone:ALL> ToneDesc(jp/record) initializing from '1400/500,0/15000' [0x5645b7d7f890] 2021-08-28_10:16:28.531923 <tone:ALL> ToneDesc(jp/info) initializing from '!950/330,!1400/330,!1800/330,0' [0x5645b7d7fa10] 2021-08-28_10:16:28.531935 <tone:ALL> ToneDesc(jp/stutter) initializing from '!400/100,!0/100,!400/100,!0/100,!400/100,!0/100,!400/100,!0/100,!400/100,!0/100,!400/100,!0/100,400' [0x5645b7d7fbd0] 2021-08-28_10:16:28.531955 <tone:ALL> ToneDesc(mx/dial) initializing from '425' [0x5645b7d80350] 2021-08-28_10:16:28.531965 <tone:ALL> ToneDesc(mx/busy) initializing from '425/250,0/250' [0x5645b7d804b0] 2021-08-28_10:16:28.531975 <tone:ALL> ToneDesc(mx/ring) initializing from '425/1000,0/4000' [0x5645b7d80630] 2021-08-28_10:16:28.531985 <tone:ALL> ToneDesc(mx/congestion) initializing from '425/250,0/250' [0x5645b7d807b0] 2021-08-28_10:16:28.531995 <tone:ALL> ToneDesc(mx/callwaiting) initializing from '425/200,0/600,425/200,0/10000' [0x5645b7d80930] 2021-08-28_10:16:28.532006 <tone:ALL> ToneDesc(mx/dialrecall) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440' [0x5645b7d80b10] 2021-08-28_10:16:28.532020 <tone:ALL> ToneDesc(mx/record) initializing from '1400/500,0/15000' [0x5645b7d80dc0] 2021-08-28_10:16:28.532029 <tone:ALL> ToneDesc(mx/info) initializing from '950/330,0/30,1400/330,0/30,1800/330,0/1000' [0x5645b7d80f40] 2021-08-28_10:16:28.532044 <tone:ALL> ToneDesc(mx/stutter) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440' [0x5645b7d811d0] 2021-08-28_10:16:28.532063 <tone:ALL> ToneDesc(my/dial) initializing from '425' [0x5645b7d818d0] 2021-08-28_10:16:28.532073 <tone:ALL> ToneDesc(my/busy) initializing from '425/500,0/500' [0x5645b7d81a30] 2021-08-28_10:16:28.532082 <tone:ALL> ToneDesc(my/ring) initializing from '425/400,0/200' [0x5645b7d81bb0] 2021-08-28_10:16:28.532092 <tone:ALL> ToneDesc(my/congestion) initializing from '425/500,0/500' [0x5645b7d81d30] 2021-08-28_10:16:28.532103 <tone:ALL> ToneDesc(nl/dial) initializing from '425' [0x5645b7d81eb0] 2021-08-28_10:16:28.532114 <tone:ALL> ToneDesc(nl/busy) initializing from '425/500,0/500' [0x5645b7d82010] 2021-08-28_10:16:28.532124 <tone:ALL> ToneDesc(nl/ring) initializing from '425/1000,0/4000' [0x5645b7d821b0] 2021-08-28_10:16:28.532134 <tone:ALL> ToneDesc(nl/congestion) initializing from '425/250,0/250' [0x5645b7d82370] 2021-08-28_10:16:28.532144 <tone:ALL> ToneDesc(nl/callwaiting) initializing from '425/500,0/9500' [0x5645b7d82530] 2021-08-28_10:16:28.532154 <tone:ALL> ToneDesc(nl/dialrecall) initializing from '425/500,0/50' [0x5645b7d826f0] 2021-08-28_10:16:28.532164 <tone:ALL> ToneDesc(nl/record) initializing from '1400/500,0/15000' [0x5645b7d82890] 2021-08-28_10:16:28.532174 <tone:ALL> ToneDesc(nl/info) initializing from '950/330,1400/330,1800/330,0/1000' [0x5645b7d82a30] 2021-08-28_10:16:28.532186 <tone:ALL> ToneDesc(nl/stutter) initializing from '425/500,0/50' [0x5645b7d82d90] 2021-08-28_10:16:28.532197 <tone:ALL> ToneDesc(no/dial) initializing from '425' [0x5645b7d82f10] 2021-08-28_10:16:28.532208 <tone:ALL> ToneDesc(no/busy) initializing from '425/500,0/500' [0x5645b7d83070] 2021-08-28_10:16:28.532219 <tone:ALL> ToneDesc(no/ring) initializing from '425/1000,0/4000' [0x5645b7d832b0] 2021-08-28_10:16:28.532229 <tone:ALL> ToneDesc(no/congestion) initializing from '425/200,0/200' [0x5645b7d834d0] 2021-08-28_10:16:28.532239 <tone:ALL> ToneDesc(no/callwaiting) initializing from '425/200,0/600,425/200,0/10000' [0x5645b7d836f0] 2021-08-28_10:16:28.532251 <tone:ALL> ToneDesc(no/dialrecall) initializing from '470/400,425/400' [0x5645b7d83a50] 2021-08-28_10:16:28.532262 <tone:ALL> ToneDesc(no/record) initializing from '1400/400,0/15000' [0x5645b7d83bd0] 2021-08-28_10:16:28.532282 <tone:ALL> ToneDesc(no/info) initializing from '!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000,0' [0x5645b7d83d50] 2021-08-28_10:16:28.532304 <tone:ALL> ToneDesc(no/stutter) initializing from '470/400,425/400' [0x5645b7d84660] 2021-08-28_10:16:28.532318 <tone:ALL> ToneDesc(nz/dial) initializing from '400' [0x5645b7d847e0] 2021-08-28_10:16:28.532328 <tone:ALL> ToneDesc(nz/busy) initializing from '400/250,0/250' [0x5645b7d84940] 2021-08-28_10:16:28.532338 <tone:ALL> ToneDesc(nz/ring) initializing from '400+450/400,0/200,400+450/400,0/2000' [0x5645b7d84ac0] 2021-08-28_10:16:28.532350 <tone:ALL> ToneDesc(nz/congestion) initializing from '400/375,0/375' [0x5645b7d84c80] 2021-08-28_10:16:28.532360 <tone:ALL> ToneDesc(nz/callwaiting) initializing from '!400/200,!0/3000,!400/200,!0/3000,!400/200,!0/3000,!400/200' [0x5645b7d84e00] 2021-08-28_10:16:28.532375 <tone:ALL> ToneDesc(nz/dialrecall) initializing from '!400/100!0/100,!400/100,!0/100,!400/100,!0/100,400' [0x5645b7d850d0] 2021-08-28_10:16:28.532389 <tone:ALL> ToneDesc(nz/record) initializing from '1400/425,0/15000' [0x5645b7d852d0] 2021-08-28_10:16:28.532399 <tone:ALL> ToneDesc(nz/info) initializing from '400/750,0/100,400/750,0/100,400/750,0/100,400/750,0/400' [0x5645b7d85450] 2021-08-28_10:16:28.532412 <tone:ALL> ToneDesc(nz/stutter) initializing from '!400/100!0/100,!400/100,!0/100,!400/100,!0/100,!400/100!0/100,!400/100,!0/100,!400/100,!0/100,400' [0x5645b7d858a0] 2021-08-28_10:16:28.532428 <tone:ALL> ToneDesc(nz/unobtainable) initializing from '400/75,0/100,400/75,0/100,400/75,0/100,400/75,0/400' [0x5645b7d85c20] 2021-08-28_10:16:28.532444 <tone:ALL> ToneDesc(ph/dial) initializing from '425' [0x5645b7d85e60] 2021-08-28_10:16:28.532455 <tone:ALL> ToneDesc(ph/busy) initializing from '480+620/500,0/500' [0x5645b7d85fc0] 2021-08-28_10:16:28.532463 <tone:ALL> Building tone of 620 + 480 Hz 2021-08-28_10:16:28.532943 <tone:ALL> ToneDesc(ph/ring) initializing from '425+480/1000,0/4000' [0x5645b7d8a060] 2021-08-28_10:16:28.532955 <tone:ALL> Building tone of 480 + 425 Hz 2021-08-28_10:16:28.533445 <tone:ALL> ToneDesc(ph/congestion) initializing from '480+620/250,0/250' [0x5645b7d8e0c0] 2021-08-28_10:16:28.533458 <tone:ALL> ToneDesc(ph/callwaiting) initializing from '440/300,0/10000' [0x5645b7d8e240] 2021-08-28_10:16:28.533469 <tone:ALL> ToneDesc(ph/dialrecall) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440' [0x5645b7d8e440] 2021-08-28_10:16:28.533484 <tone:ALL> ToneDesc(ph/record) initializing from '1400/500,0/15000' [0x5645b7d8e970] 2021-08-28_10:16:28.533494 <tone:ALL> ToneDesc(ph/info) initializing from '!950/330,!1400/330,!1800/330,0' [0x5645b7d8eaf0] 2021-08-28_10:16:28.533506 <tone:ALL> ToneDesc(ph/stutter) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440' [0x5645b7d8ecb0] 2021-08-28_10:16:28.533528 <tone:ALL> ToneDesc(pl/dial) initializing from '425' [0x5645b7d8f450] 2021-08-28_10:16:28.533539 <tone:ALL> ToneDesc(pl/busy) initializing from '425/500,0/500' [0x5645b7d8f5b0] 2021-08-28_10:16:28.533550 <tone:ALL> ToneDesc(pl/ring) initializing from '425/1000,0/4000' [0x5645b7d8f730] 2021-08-28_10:16:28.533560 <tone:ALL> ToneDesc(pl/congestion) initializing from '425/500,0/500' [0x5645b7d8f8b0] 2021-08-28_10:16:28.533570 <tone:ALL> ToneDesc(pl/callwaiting) initializing from '425/150,0/150,425/150,0/4000' [0x5645b7d8fa30] 2021-08-28_10:16:28.533582 <tone:ALL> ToneDesc(pl/dialrecall) initializing from '425/500,0/50' [0x5645b7d8fc10] 2021-08-28_10:16:28.533593 <tone:ALL> ToneDesc(pl/record) initializing from '1400/500,0/15000' [0x5645b7d8fd90] 2021-08-28_10:16:28.533604 <tone:ALL> ToneDesc(pl/info) initializing from '!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000,!950/330,!1400/330,!1800/330,!0/1000' [0x5645b7d8ff10] 2021-08-28_10:16:28.533623 <tone:ALL> ToneDesc(pl/stutter) initializing from '!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,425' [0x5645b7d90600] 2021-08-28_10:16:28.533642 <tone:ALL> ToneDesc(pt/dial) initializing from '425' [0x5645b7d909e0] 2021-08-28_10:16:28.533652 <tone:ALL> ToneDesc(pt/busy) initializing from '425/500,0/500' [0x5645b7d90b40] 2021-08-28_10:16:28.533662 <tone:ALL> ToneDesc(pt/ring) initializing from '425/1000,0/5000' [0x5645b7d90cc0] 2021-08-28_10:16:28.533673 <tone:ALL> ToneDesc(pt/congestion) initializing from '425/200,0/200' [0x5645b7d90e40] 2021-08-28_10:16:28.533684 <tone:ALL> ToneDesc(pt/callwaiting) initializing from '440/300,0/10000' [0x5645b7d90fc0] 2021-08-28_10:16:28.533695 <tone:ALL> ToneDesc(pt/dialrecall) initializing from '425/1000,0/200' [0x5645b7d91140] 2021-08-28_10:16:28.533705 <tone:ALL> ToneDesc(pt/record) initializing from '1400/500,0/15000' [0x5645b7d912c0] 2021-08-28_10:16:28.533714 <tone:ALL> ToneDesc(pt/info) initializing from '950/330,1400/330,1800/330,0/1000' [0x5645b7d91460] 2021-08-28_10:16:28.533726 <tone:ALL> ToneDesc(pt/stutter) initializing from '!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,425' [0x5645b7d916a0] 2021-08-28_10:16:28.533745 <tone:ALL> ToneDesc(ru/dial) initializing from '425' [0x5645b7d91e20] 2021-08-28_10:16:28.533755 <tone:ALL> ToneDesc(ru/busy) initializing from '425/350,0/350' [0x5645b7d91f80] 2021-08-28_10:16:28.533768 <tone:ALL> ToneDesc(ru/ring) initializing from '425/800,0/3200' [0x5645b7d92100] 2021-08-28_10:16:28.533778 <tone:ALL> ToneDesc(ru/congestion) initializing from '425/350,0/350' [0x5645b7d92280] 2021-08-28_10:16:28.533788 <tone:ALL> ToneDesc(ru/callwaiting) initializing from '425/200,0/5000' [0x5645b7d92400] 2021-08-28_10:16:28.533798 <tone:ALL> ToneDesc(ru/dialrecall) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440' [0x5645b7d92580] 2021-08-28_10:16:28.533813 <tone:ALL> ToneDesc(ru/record) initializing from '1400/500,0/15000' [0x5645b7d92850] 2021-08-28_10:16:28.533823 <tone:ALL> ToneDesc(ru/info) initializing from '!950/330,!1400/330,!1800/330,0' [0x5645b7d929d0] 2021-08-28_10:16:28.533836 <tone:ALL> ToneDesc(se/dial) initializing from '425' [0x5645b7d92b90] 2021-08-28_10:16:28.533846 <tone:ALL> ToneDesc(se/busy) initializing from '425/250,0/250' [0x5645b7d92cf0] 2021-08-28_10:16:28.533856 <tone:ALL> ToneDesc(se/ring) initializing from '425/1000,0/5000' [0x5645b7d92eb0] 2021-08-28_10:16:28.533870 <tone:ALL> ToneDesc(se/congestion) initializing from '425/250,0/750' [0x5645b7d93070] 2021-08-28_10:16:28.533880 <tone:ALL> ToneDesc(se/callwaiting) initializing from '425/200,0/500,425/200,0/9100' [0x5645b7d93290] 2021-08-28_10:16:28.533892 <tone:ALL> ToneDesc(se/dialrecall) initializing from '!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,425' [0x5645b7d935f0] 2021-08-28_10:16:28.533905 <tone:ALL> ToneDesc(se/record) initializing from '1400/500,0/15000' [0x5645b7d93a10] 2021-08-28_10:16:28.533915 <tone:ALL> ToneDesc(se/info) initializing from '!950/332,!0/24,!1400/332,!0/24,!1800/332,!0/2024,!950/332,!0/24,!1400/332,!0/24,!1800/332,!0/2024,!950/332,!0/24,!1400/332,!0/24,!1800/332,!0/2024,!950/332,!0/24,!1400/332,!0/24,!1800/332,!0/2024,!950/332,!0/24,!1400/332,!0/24,!1800/332,0' [0x5645b7d93b90] 2021-08-28_10:16:28.533945 <tone:ALL> ToneDesc(se/stutter) initializing from '!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,!425/100,!0/100,425' [0x5645b7d94d30] 2021-08-28_10:16:28.533966 <tone:ALL> ToneDesc(sg/dial) initializing from '425' [0x5645b7d95010] 2021-08-28_10:16:28.533976 <tone:ALL> ToneDesc(sg/ring) initializing from '425*24/400,0/200,425*24/400,0/2000' [0x5645b7d95170] 2021-08-28_10:16:28.533984 <tone:ALL> Building tone of 425 modulated by 24 Hz 2021-08-28_10:16:28.534412 <tone:ALL> ToneDesc(sg/busy) initializing from '425/750,0/750' [0x5645b7d948b0] 2021-08-28_10:16:28.534424 <tone:ALL> ToneDesc(sg/congestion) initializing from '425/250,0/250' [0x5645b7d94920] 2021-08-28_10:16:28.534434 <tone:ALL> ToneDesc(sg/callwaiting) initializing from '425*24/300,0/200,425*24/300,0/3200' [0x5645b7d93f80] 2021-08-28_10:16:28.534447 <tone:ALL> ToneDesc(sg/stutter) initializing from '!425/200,!0/200,!425/600,!0/200,!425/200,!0/200,!425/600,!0/200,!425/200,!0/200,!425/600,!0/200,!425/200,!0/200,!425/600,!0/200,425' [0x5645b7d94180] 2021-08-28_10:16:28.534466 <tone:ALL> ToneDesc(sg/info) initializing from '950/330,1400/330,1800/330,0/1000' [0x5645b7d998f0] 2021-08-28_10:16:28.534478 <tone:ALL> ToneDesc(sg/dialrecall) initializing from '425*24/500,0/500,425/500,0/2500' [0x5645b7d99a70] 2021-08-28_10:16:28.534490 <tone:ALL> ToneDesc(sg/record) initializing from '1400/500,0/15000' [0x5645b7d99bf0] 2021-08-28_10:16:28.534500 <tone:ALL> ToneDesc(sg/nutone) initializing from '425/2500,0/500' [0x5645b7d99d70] 2021-08-28_10:16:28.534510 <tone:ALL> ToneDesc(sg/intrusion) initializing from '425/250,0/2000' [0x5645b7d99ef0] 2021-08-28_10:16:28.534523 <tone:ALL> ToneDesc(sg/warning) initializing from '425/624,0/4376' [0x5645b7d9a070] 2021-08-28_10:16:28.534534 <tone:ALL> ToneDesc(sg/acceptance) initializing from '425/125,0/125' [0x5645b7d9a1f0] 2021-08-28_10:16:28.534544 <tone:ALL> ToneDesc(sg/holdinga) initializing from '!425*24/500,!0/500' [0x5645b7d9a370] 2021-08-28_10:16:28.534555 <tone:ALL> ToneDesc(sg/holdingb) initializing from '!425/500,!0/2500' [0x5645b7d9a4f0] 2021-08-28_10:16:28.534566 <tone:ALL> ToneDesc(th/dial) initializing from '400*50' [0x5645b7d9a670] 2021-08-28_10:16:28.534573 <tone:ALL> Building tone of 400 modulated by 50 Hz 2021-08-28_10:16:28.535122 <tone:ALL> ToneDesc(th/busy) initializing from '400/500,0/500' [0x5645b7d9e700] 2021-08-28_10:16:28.535134 <tone:ALL> ToneDesc(th/ring) initializing from '420/1000,0/5000' [0x5645b7d9e880] 2021-08-28_10:16:28.535145 <tone:ALL> ToneDesc(th/congestion) initializing from '400/300,0/300' [0x5645b7d9ea60] 2021-08-28_10:16:28.535155 <tone:ALL> ToneDesc(th/callwaiting) initializing from '1000/400,10000/400,1000/400' [0x5645b7d9ec20] 2021-08-28_10:16:28.535163 <tone:ALL> Building tone of 10000 Hz 2021-08-28_10:16:28.535584 <tone:ALL> ToneDesc(th/dialrecall) initializing from '400*50/400,0/100,400*50/400,0/100' [0x5645b7da0f30] 2021-08-28_10:16:28.535598 <tone:ALL> ToneDesc(th/record) initializing from '1400/500,0/15000' [0x5645b7da11f0] 2021-08-28_10:16:28.535609 <tone:ALL> ToneDesc(th/info) initializing from '950/330,1400/330,1800/330' [0x5645b7da1370] 2021-08-28_10:16:28.535620 <tone:ALL> ToneDesc(th/stutter) initializing from '!400/200,!0/200,!400/600,!0/200,!400/200,!0/200,!400/600,!0/200,!400/200,!0/200,!400/600,!0/200,!400/200,!0/200,!400/600,!0/200,400' [0x5645b7da15b0] 2021-08-28_10:16:28.535643 <tone:ALL> ToneDesc(uk/dial) initializing from '350+440' [0x5645b7da2090] 2021-08-28_10:16:28.535654 <tone:ALL> ToneDesc(uk/specdial) initializing from '350+440/750,440/750' [0x5645b7da21f0] 2021-08-28_10:16:28.535665 <tone:ALL> ToneDesc(uk/busy) initializing from '400/375,0/375' [0x5645b7da2370] 2021-08-28_10:16:28.535676 <tone:ALL> ToneDesc(uk/congestion) initializing from '400/400,0/350,400/225,0/525' [0x5645b7da24f0] 2021-08-28_10:16:28.535687 <tone:ALL> ToneDesc(uk/speccongestion) initializing from '400/200,1004/300' [0x5645b7da26b0] 2021-08-28_10:16:28.535695 <tone:ALL> Building tone of 1004 Hz 2021-08-28_10:16:28.535810 <tone:ALL> ToneDesc(uk/unobtainable) initializing from '400' [0x5645b7da4810] 2021-08-28_10:16:28.535823 <tone:ALL> ToneDesc(uk/ring) initializing from '400+450/400,0/200,400+450/400,0/2000' [0x5645b7da4900] 2021-08-28_10:16:28.535836 <tone:ALL> ToneDesc(uk/callwaiting) initializing from '400/100,0/4000' [0x5645b7da4a80] 2021-08-28_10:16:28.535847 <tone:ALL> ToneDesc(uk/speccallwaiting) initializing from '400/250,0/250,400/250,0/250,400/250,0/5000' [0x5645b7da4c00] 2021-08-28_10:16:28.535861 <tone:ALL> ToneDesc(uk/creditexpired) initializing from '400/125,0/125' [0x5645b7da4f10] 2021-08-28_10:16:28.535873 <tone:ALL> ToneDesc(uk/confirm) initializing from '1400' [0x5645b7da5090] 2021-08-28_10:16:28.535884 <tone:ALL> ToneDesc(uk/switching) initializing from '400/200,0/400,400/2000,0/400' [0x5645b7da51f0] 2021-08-28_10:16:28.535896 <tone:ALL> ToneDesc(uk/info) initializing from '950/330,0/15,1400/330,0/15,1800/330,0/1000' [0x5645b7da5430] 2021-08-28_10:16:28.535909 <tone:ALL> ToneDesc(uk/record) initializing from '1400/500,0/60000' [0x5645b7da57c0] 2021-08-28_10:16:28.535920 <tone:ALL> ToneDesc(uk/stutter) initializing from '350+440/750,440/750' [0x5645b7da5940] 2021-08-28_10:16:28.535932 <tone:ALL> ToneDesc(us/dial) initializing from '350+440' [0x5645b7da5ac0] 2021-08-28_10:16:28.535943 <tone:ALL> ToneDesc(us/busy) initializing from '480+620/500,0/500' [0x5645b7da5c20] 2021-08-28_10:16:28.535953 <tone:ALL> ToneDesc(us/ring) initializing from '440+480/2000,0/4000' [0x5645b7da5de0] 2021-08-28_10:16:28.535962 <tone:ALL> Building tone of 480 + 440 Hz 2021-08-28_10:16:28.536442 <tone:ALL> ToneDesc(us/congestion) initializing from '480+620/250,0/250' [0x5645b7da9fb0] 2021-08-28_10:16:28.536455 <tone:ALL> ToneDesc(us/callwaiting) initializing from '440/300,0/10000' [0x5645b7daa1d0] 2021-08-28_10:16:28.536466 <tone:ALL> ToneDesc(us/dialrecall) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440' [0x5645b7daa3f0] 2021-08-28_10:16:28.536481 <tone:ALL> ToneDesc(us/record) initializing from '1400/500,0/15000' [0x5645b7daa920] 2021-08-28_10:16:28.536492 <tone:ALL> ToneDesc(us/info) initializing from '!950/330,!1400/330,!1800/330,0' [0x5645b7daaaa0] 2021-08-28_10:16:28.536504 <tone:ALL> ToneDesc(us/stutter) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440' [0x5645b7daac60] 2021-08-28_10:16:28.536526 <tone:ALL> ToneDesc(us-old/dial) initializing from '600*120' [0x5645b7dab400] 2021-08-28_10:16:28.536533 <tone:ALL> Building tone of 600 modulated by 120 Hz 2021-08-28_10:16:28.537016 <tone:ALL> ToneDesc(us-old/busy) initializing from '500*100/500,0/500' [0x5645b7daae60] 2021-08-28_10:16:28.537024 <tone:ALL> Building tone of 500 modulated by 100 Hz 2021-08-28_10:16:28.537618 <tone:ALL> ToneDesc(us-old/ring) initializing from '420*40/2000,0/4000' [0x5645b7dab140] 2021-08-28_10:16:28.537629 <tone:ALL> Building tone of 420 modulated by 40 Hz 2021-08-28_10:16:28.538071 <tone:ALL> ToneDesc(us-old/congestion) initializing from '500*100/250,0/250' [0x5645b7db7410] 2021-08-28_10:16:28.538090 <tone:ALL> ToneDesc(us-old/callwaiting) initializing from '440/300,0/10000' [0x5645b7db7640] 2021-08-28_10:16:28.538103 <tone:ALL> ToneDesc(us-old/dialrecall) initializing from '!600*120/100,!0/100,!600*120/100,!0/100,!600*120/100,!0/100,600*120' [0x5645b7db7860] 2021-08-28_10:16:28.538119 <tone:ALL> ToneDesc(us-old/record) initializing from '1400/500,0/15000' [0x5645b7db7da0] 2021-08-28_10:16:28.538130 <tone:ALL> ToneDesc(us-old/info) initializing from '!950/330,!1400/330,!1800/330,0' [0x5645b7db7f20] 2021-08-28_10:16:28.538144 <tone:ALL> ToneDesc(us-old/stutter) initializing from '!600*120/100,!0/100,!600*120/100,!0/100,!600*120/100,!0/100,!600*120/100,!0/100,!600*120/100,!0/100,!600*120/100,!0/100,600*120' [0x5645b7db80e0] 2021-08-28_10:16:28.538168 <tone:ALL> ToneDesc(tw/dial) initializing from '350+440' [0x5645b7db8880] 2021-08-28_10:16:28.538179 <tone:ALL> ToneDesc(tw/busy) initializing from '480+620/500,0/500' [0x5645b7db89e0] 2021-08-28_10:16:28.538191 <tone:ALL> ToneDesc(tw/ring) initializing from '440+480/1000,0/2000' [0x5645b7db8b60] 2021-08-28_10:16:28.538203 <tone:ALL> ToneDesc(tw/congestion) initializing from '480+620/250,0/250' [0x5645b7db8ce0] 2021-08-28_10:16:28.538214 <tone:ALL> ToneDesc(tw/callwaiting) initializing from '350+440/250,0/250,350+440/250,0/3250' [0x5645b7db8e60] 2021-08-28_10:16:28.538229 <tone:ALL> ToneDesc(tw/dialrecall) initializing from '300/1500,0/500' [0x5645b7db9050] 2021-08-28_10:16:28.538237 <tone:ALL> Building tone of 300 Hz 2021-08-28_10:16:28.538372 <tone:ALL> ToneDesc(tw/record) initializing from '1400/500,0/15000' [0x5645b7dbb1b0] 2021-08-28_10:16:28.538384 <tone:ALL> ToneDesc(tw/info) initializing from '!950/330,!1400/330,!1800/330,0' [0x5645b7dbb330] 2021-08-28_10:16:28.538397 <tone:ALL> ToneDesc(tw/stutter) initializing from '!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,!350+440/100,!0/100,350+440' [0x5645b7dbb5a0] 2021-08-28_10:16:28.538418 <tone:ALL> ToneDesc(ve/dial) initializing from '425' [0x5645b7dbbda0] 2021-08-28_10:16:28.538429 <tone:ALL> ToneDesc(ve/busy) initializing from '425/500,0/500' [0x5645b7dbbf00] 2021-08-28_10:16:28.538442 <tone:ALL> ToneDesc(ve/ring) initializing from '425/1000,0/4000' [0x5645b7dbc080] 2021-08-28_10:16:28.538454 <tone:ALL> ToneDesc(ve/congestion) initializing from '425/250,0/250' [0x5645b7dbc200] 2021-08-28_10:16:28.538465 <tone:ALL> ToneDesc(ve/callwaiting) initializing from '400+450/300,0/6000' [0x5645b7dbc380] 2021-08-28_10:16:28.538476 <tone:ALL> ToneDesc(ve/dialrecall) initializing from '425' [0x5645b7dbc500] 2021-08-28_10:16:28.538487 <tone:ALL> ToneDesc(ve/record) initializing from '1400/500,0/15000' [0x5645b7dbc660] 2021-08-28_10:16:28.538498 <tone:ALL> ToneDesc(ve/info) initializing from '!950/330,!1440/330,!1800/330,0/1000' [0x5645b7dbc800] 2021-08-28_10:16:28.538506 <tone:ALL> Building tone of 1440 Hz 2021-08-28_10:16:28.538646 <tone:ALL> ToneDesc(za/dial) initializing from '400*33' [0x5645b7dbea50] 2021-08-28_10:16:28.538654 <tone:ALL> Building tone of 400 modulated by 33 Hz 2021-08-28_10:16:28.539191 <tone:ALL> ToneDesc(za/ring) initializing from '400*33/400,0/200,400*33/400,0/2000' [0x5645b7dc2ae0] 2021-08-28_10:16:28.539205 <tone:ALL> ToneDesc(za/callwaiting) initializing from '400*33/250,0/250,400*33/250,0/250,400*33/250,0/250,400*33/250,0/250' [0x5645b7dc2e70] 2021-08-28_10:16:28.539223 <tone:ALL> ToneDesc(za/congestion) initializing from '400/250,0/250' [0x5645b7dc3350] 2021-08-28_10:16:28.539235 <tone:ALL> ToneDesc(za/busy) initializing from '400/500,0/500' [0x5645b7dc34d0] 2021-08-28_10:16:28.539247 <tone:ALL> ToneDesc(za/dialrecall) initializing from '350+440' [0x5645b7dc3650] 2021-08-28_10:16:28.539258 <tone:ALL> ToneDesc(za/record) initializing from '1400/500,0/10000' [0x5645b7dc37c0] 2021-08-28_10:16:28.539270 <tone:ALL> ToneDesc(za/info) initializing from '950/330,1400/330,1800/330,0/330' [0x5645b7dc3940] 2021-08-28_10:16:28.539284 <tone:ALL> ToneDesc(za/stutter) initializing from '!400*33/100,!0/100,!400*33/100,!0/100,!400*33/100,!0/100,!400*33/100,!0/100,!400*33/100,!0/100,!400*33/100,!0/100,400*33' [0x5645b7dc3be0] Initializing module SIP Channel 2021-08-28_10:16:28.539543 <sip:ALL> Initialized audio codecs: mulaw,alaw,gsm,slin,g722/16000,ilbc20,ilbc30,isac/16000,isac/32000 2021-08-28_10:16:28.539632 <sip:ALL> YateSIPEndPoint::YateSIPEndPoint(normal) [0x5645b7cffce0] 2021-08-28_10:16:28.539707 <sip:ALL> Transport(general) created [0x5645b7d03040] 2021-08-28_10:16:28.539727 <sip:ALL> Listener(UDP,'general') initialized addr=':5060' default=true maxpkt=1500 rtp_localip=(null) nat_address=(null) [0x5645b7d03040] 2021-08-28_10:16:28.539762 <sip:INFO> Default UDP transport is 'general' Initializing module WireSniff 2021-08-28_10:16:28.539821 <sip:ALL> Listener(UDP,'general') initializing socket addr='(null)' port=5060 Initializing module Conference 2021-08-28_10:16:28.539923 <sip:INFO> Listener(UDP,'general') started on ':5060' (IPv4) Initializing module YIAX 2021-08-28_10:16:28.540015 <iax:ALL> Enabled audio format(s) 'gsm,ilbc30,mulaw,alaw,slin,g722/16000' default=g722/16000 2021-08-28_10:16:28.540027 <iax:ALL> No video format(s) available 2021-08-28_10:16:28.540108 <iaxengine:INFO> Bound on '0.0.0.0:4569' [0x5645b7dc44f0] 2021-08-28_10:16:28.540120 <iaxengine:ALL> Adjust ts out set to thres=120 over=120 under=60 [0x5645b7dc44f0] 2021-08-28_10:16:28.540130 <iaxengine:INFO> Status changed Idle -> Listening [0x5645b7dc44f0] 2021-08-28_10:16:28.540137 <iax:INFO> Added listener (0x5645b7dc44f0) 'iaxengine' status='Listening' 2021-08-28_10:16:28.540227 <iaxengine:ALL> Created 3 'YIAXListener' threads [0x5645b7dc44f0] 2021-08-28_10:16:28.540302 <iaxengine:ALL> Created 3 'YIAXGetEvent' threads [0x5645b7dc44f0] 2021-08-28_10:16:28.540333 <iaxengine:ALL> Created 1 'YIAXTrunking' threads [0x5645b7dc44f0] 2021-08-28_10:16:28.540348 <iax:INFO> Default listener is 'iaxengine' Initializing module CdrBuild Initializing module ToneDetector Initializing module FileInfo Initializing module GVoice Initializing module DumbChannel DumbChannel initialized Initializing module iSAC Initializing module MsgSniffer 2021-08-28_10:16:28.540608 <INFO> Registered broadcast message handler 0x5645b7d00300 Initializing module File Transfer 2021-08-28_10:16:28.540672 <filetransfer:INFO> Initialized send_chunk_size=4096 send_interval=50ms send_linger_intervals=20 notify_progress=false Initializing module G722 Initializing module RManager 2021-08-28_10:16:28.540737 <RManager:INFO> Starting listener 'general' on 127.0.0.1:5038 Initializing module Analyzer Initializing module MOH Initializing module Call Generator 2021-08-28_10:16:28.540901 <CallGen:INFO> CleanThread::run() [0x5645b7d0f9e0] Initializing module PBX 2021-08-28_10:16:28.540946 <CallGen:INFO> GenThread::run() [0x5645b7d0fbe0] Initializing module iLBC webrtc Initializing module WaveFile Initializing module Call Forker 2021-08-28_10:16:28.541131 <callfork:INFO> Default fork for 'chan.dtmf' matching 'peerid' priority 100 Initializing module SIP Features 2021-08-28_10:16:28.541166 <sipfeatures:ALL> Allowed subscriptions: dialog,message-summary Initializing module SNMP Agent 2021-08-28_10:16:28.545461 <snmpagent:ALL> SnmpMsgQueue created for 0.0.0.0:20211 with priority 'normal' 2021-08-28_10:16:28.545589 <snmpagent:INFO> SNMP UDP Listener initialized on port 20211 Initializing module Call Parking Initializing module Cache Initializing module MrcpSpeech Initializing module Users Management Initializing module MGCP Gateway 2021-08-28_10:16:28.546046 <mgcp_gw:INFO> Initialized: type: Gateway bind address: :2427 allow_unknown_cmd: false retrans_interval: 250000 retrans_count: 3 lower_case_params: true max_recv_packet: 1500 send_provisional: true 2021-08-28_10:16:28.546106 <mgcpgw:ALL> Initialized audio codecs: mulaw,alaw,gsm,slin,g722/16000,ilbc20,ilbc30,isac/16000,isac/32000 Initializing module Signalling Channel 2021-08-28_10:16:28.546308 <sig/isup.decode:INFO> ISUP Call Controller pointcode-type=ITU format=alaw plan/type/pres/screen=unknown/unknown/allowed/user-provided caller-category=ordinary remote-pointcode=1-1-1 SIF/SSF=5/128 lockcircuits= userpartavail=false lockgroup=true mediareq=no outboundsls=cic [0x5645b7ddae40] 2021-08-28_10:16:28.546337 <sig/isup.encode:INFO> ISUP Call Controller pointcode-type=ITU format=alaw plan/type/pres/screen=unknown/unknown/allowed/user-provided caller-category=ordinary remote-pointcode=1-1-1 SIF/SSF=5/128 lockcircuits= userpartavail=false lockgroup=true mediareq=no outboundsls=cic [0x5645b7ddc420] 2021-08-28_10:16:28.546383 <sig:NOTE> Section 'tcapuser_test'. Unknown/missing type '(null)' Initializing module Monitoring 2021-08-28_10:16:28.546513 <monitoring:ALL> RTPTable created [0x5645b7dde7a0] 2021-08-28_10:16:28.546526 <monitoring:ALL> RTPTable [0x5645b7dde7a0] configured with directions='(null)',resetTime=3600 Initializing module Late Router Initializing module Presence 2021-08-28_10:16:28.546642 <presence:ALL> Initialized lists=16 expirecheck=0 expiretime=0 account=(null) Initializing module YBTS 2021-08-28_10:16:28.546775 <ybts:INFO> LAI changed (null) -> 28607_03e8 Initializing module Queues Notify 2021-08-28_10:16:28.546916 <queuesnotify:INFO> Query 'callinfo' not configured 2021-08-28_10:16:28.546926 <queuesnotify:INFO> Query 'cdrinfo' not configured 2021-08-28_10:16:28.546933 <queuesnotify:ALL> Initialized: account= notifyhanguponunload=true Initializing module Register for database Initializing module PBX for database Initializing module Accounts from file Initializing module Analog Channel Initializing module Queues for database Initializing module GSM Transceiver 2021-08-28_10:16:28.547441 <gsmtrx:INFO> Socket(control) bound on 127.0.0.1:5700 (remote: 127.0.0.1:5701) [0x5645b7de94e0] 2021-08-28_10:16:28.547480 <gsmtrx:INFO> Module state changed Idle -> Waiting Initializing module Register from file Initializing module Radius client 2021-08-28_10:16:28.547626 <yradius:NOTE> Local address not set or invalid. Radius functions disabled Initializing module CCongestion Initializing module Radio Test Initialization complete 2021-08-28_10:16:28.547700 <ALL> Engine dispatching start message 2021-08-28_10:16:28.547819 <ybts:NOTE> YBTSDriver State changed Idle -> Starting restart counter 1/10 2021-08-28_10:16:28.547889 <transceiver:ALL> Started worker thread [0x5645b7de4e80] 2021-08-28_10:16:28.547906 <transceiver:INFO> Started [0x5645b7de4e80] 2021-08-28_10:16:28.547950 <mbts:ALL> Started worker thread [0x5645b7de50c0] 2021-08-28_10:16:28.547960 <mbts:INFO> Started [0x5645b7de50c0] 2021-08-28_10:16:28.547976 <ybts-command:INFO> Started [0x5645b7de5320] 2021-08-28_10:16:28.548012 <ybts-signalling:ALL> Started worker thread [0x5645b7de5760] 2021-08-28_10:16:28.548023 <ybts-signalling:INFO> Started [0x5645b7de5760] 2021-08-28_10:16:28.548057 <ybts-media:ALL> Started worker thread [0x5645b7de5480] 2021-08-28_10:16:28.548067 <ybts-media:INFO> Started [0x5645b7de5480] 2021-08-28_10:16:28.548074 <ybts:ALL> Starting peer '/usr/local/lib/yate/server/bts/mbts' '(null)' 2021-08-28_10:16:28.548783 <ybts:INFO> Started peer pid=19170 2021-08-28_10:16:28.548851 <ybts:NOTE> YBTSDriver State changed Starting -> WaitHandshake 2021-08-28_10:16:28.548867 <ybts:ALL> Restart scheduled in 120000ms [0x7f8f57e66b00] MBTS connected to YBTS Yate-BTS MBTS Component Copyright 2008, 2009, 2010 Free Software Foundation, Inc. Copyright 2010 Kestrel Signal Processing, Inc. Copyright 2011, 2012, 2013 Range Networks, Inc. Copyright 2013, 2014 Null Team Impex SRL Copyright 2014 Legba, Inc. "OpenBTS" is a registered trademark of Range Networks, Inc. Contributors: SC Null Team Impex SRL: Paul Chitescu Legba, Inc. David Burgess Range Networks, Inc.: David Burgess, Harvind Samra, Donald Kirker, Doug Brown, Pat Thompson, Kurtis Heimerl Kestrel Signal Processing, Inc.: David Burgess, Harvind Samra, Raffi Sevlian, Roshan Baliga GNU Radio: Johnathan Corgan Others: Anne Kwong, Jacob Appelbaum, Joshua Lackey, Alon Levy Alexander Chemeris, Alberto Escudero-Pascual Incorporated L/GPL libraries and components: libusb, LGPL 2.1, various copyright holders, www.libusb.org Incorporated BSD/MIT-style libraries and components: A5/1 Pedagogical Implementation, Simplified BSD License, Copyright 1998-1999 Marc Briceno, Ian Goldberg, and David Wagner Incorporated public domain libraries and components: sqlite3, released to public domain 15 Sept 2001, www.sqlite.org This program comes with ABSOLUTELY NO WARRANTY. Use of this software may be subject to other legal restrictions, including patent licensing and radio spectrum licensing. All users of this software are expected to comply with applicable regulations and laws. See the LEGAL file in the source code for more information. Release 6.1.1 formal build date Aug 22 2021 rev 2021-08-28_10:16:28.554631 <mbts:NOTE> proc 19170 GSMConfig.cpp:80:regenerateBeacon: thread 140433301886784: regenerating system information messages, changemark 1 Starting MBTS... 2021-08-28_10:16:28.554852 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD RESET 1 2021-08-28_10:16:28.554994 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: Handshake Info: 0 ----- 2021-08-28_10:16:28.555045 <ybts:NOTE> YBTSDriver State changed WaitHandshake -> Running 2021-08-28_10:16:28.555081 <ybts-signalling:INFO> Sending [0x5645b7de5760] ----- Primitive: Handshake Info: 0 ----- 2021-08-28_10:16:28.556018 >>> RSP RESET ANSWER 2021-08-28_10:16:28.556103 >>> BrfModule::createIface() 2021-08-28_10:16:28.556141 <bladerf/1:ALL> Interface created [0x7f8f300011d0] 2021-08-28_10:16:28.568705 <javascript:INFO> Parsed 'nipc' script: /usr/local/share/yate/scripts/nipc.js 2021-08-28_10:16:28.571355 <nipc:INFO> Finished reading saved registered subscribers. Found 5 registered_subscribers. 2021-08-28_10:16:28.571630 <nipc:INFO> Checked that only NiPC is enabled. 2021-08-28_10:16:28.571668 <ALL> Rescanning handler list for 'engine.start' [0x7ffe3b1553a0] at priority 100 Yate engine is initialized and starting up on sandbox-HP-255-G8-Notebook-PC 2021-08-28_10:16:28.571759 <INFO> Creating first 1 message dispatching threads and semaphore [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:618] AGC commands for FPGA v0.7.1 are incompatible with this version of libbladeRF. Please update to FPGA v0.8.0 or newer to use AGC. 2021-08-28_10:16:28.719648 <bladerf:ALL> Initialized libbladerf context 2021-08-28_10:16:28.719798 <bladerf/1:ALL> Created device (0x7f8f30001410) [0x7f8f300011d0] bladeRF detected, attached to serial=4a8a54b4dd653717e25379477a05909c 2021-08-28_10:16:28.719852 <<< BrfModule::createIface() 2021-08-28_10:16:28.719945 <gsmtrx:ALL> Adjusting parameter arfcns='1' -> 4 [0x7f8f300213f0] 2021-08-28_10:16:28.720426 <gsmtrx:ALL> Initialized [0x7f8f300213f0] ----- ARFCNs=4 oversampling=8 ----- 2021-08-28_10:16:28.728914 <gsmtrx:INFO> radio_latency_slots changed 0 -> 5 [0x7f8f300213f0] 2021-08-28_10:16:28.728983 <gsmtrx:INFO> tx_slots changed 1 -> 16 [0x7f8f300213f0] 2021-08-28_10:16:28.729013 <gsmtrx:INFO> Transceiver initialized radio=(0x7f8f300011d0) 'bladerf/1' [0x7f8f300213f0] 2021-08-28_10:16:28.729035 <gsmtrx:NOTE> Transceiver State changed Invalid -> Idle [0x7f8f300213f0] 2021-08-28_10:16:28.729060 <gsmtrx:ALL> Starting [0x7f8f300213f0] 2021-08-28_10:16:28.729109 <gsmtrx:INFO> Socket(clock) bound on 127.0.0.1:5702 (remote: 127.0.0.1:5703) [0x7f8f300213f0] 2021-08-28_10:16:28.729162 <gsmtrx:INFO> ARFCN[0]: Socket(data) bound on 127.0.0.1:5704 (remote: 127.0.0.1:5705) [0x7f8f3001c110] 2021-08-28_10:16:28.729202 <gsmtrx:INFO> ARFCN[1]: Socket(data) bound on 127.0.0.1:5706 (remote: 127.0.0.1:5707) [0x7f8f3000c2b0] 2021-08-28_10:16:28.729240 <gsmtrx:INFO> ARFCN[2]: Socket(data) bound on 127.0.0.1:5708 (remote: 127.0.0.1:5709) [0x7f8f3000f7e0] 2021-08-28_10:16:28.729277 <gsmtrx:INFO> ARFCN[3]: Socket(data) bound on 127.0.0.1:5710 (remote: 127.0.0.1:5711) [0x7f8f30026500] 2021-08-28_10:16:28.729298 <gsmtrx:NOTE> Transceiver State changed Idle -> PowerOff [0x7f8f300213f0] 2021-08-28_10:16:28.729319 <gsmtrx:INFO> Module state changed Waiting -> Running 2021-08-28_10:16:28.729344 <<< RSP RESET ANSWER 2021-08-28_10:16:28.729519 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP RESET 0 to command CMD RESET 1 2021-08-28_10:16:28.729576 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD STATISTICS OFF 2021-08-28_10:16:28.730713 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP STATISTICS 0 to command CMD STATISTICS OFF 2021-08-28_10:16:28.730772 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 READFACTORY sdrsn 2021-08-28_10:16:28.731832 <gsmtrx:ALL> Handling command 'CMD 0 READFACTORY sdrsn' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.731883 <gsmtrx:INFO> Command 'CMD 0 READFACTORY sdrsn' (ARFCN=0) 2021-08-28_10:16:28.731927 <gsmtrx:INFO> Response 'RSP READFACTORY 0 0' (ARFCN=0) 2021-08-28_10:16:28.732009 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP READFACTORY 0 0 to command CMD 0 READFACTORY sdrsn 2021-08-28_10:16:28.732150 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 RXTUNE 1710200 2021-08-28_10:16:28.733279 <gsmtrx:ALL> Handling command 'CMD 0 RXTUNE 1710200' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.735161 <gsmtrx:INFO> Command 'CMD 0 RXTUNE 1710200' (ARFCN=0) 2021-08-28_10:16:28.735233 <gsmtrx:INFO> Response 'RSP RXTUNE 0 1710800000' (ARFCN=0) 2021-08-28_10:16:28.735347 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP RXTUNE 0 1710800000 to command CMD 0 RXTUNE 1710200 2021-08-28_10:16:28.735392 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 TXTUNE 1805200 2021-08-28_10:16:28.736435 <gsmtrx:ALL> Handling command 'CMD 0 TXTUNE 1805200' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.738309 <gsmtrx:INFO> Command 'CMD 0 TXTUNE 1805200' (ARFCN=0) 2021-08-28_10:16:28.738374 <gsmtrx:INFO> Response 'RSP TXTUNE 0 1805800000' (ARFCN=0) 2021-08-28_10:16:28.738455 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP TXTUNE 0 1805800000 to command CMD 0 TXTUNE 1805200 2021-08-28_10:16:28.738495 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETTSC 2 2021-08-28_10:16:28.739598 <gsmtrx:ALL> Handling command 'CMD 0 SETTSC 2' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.739654 <gsmtrx:INFO> TSC changed 0 -> 2 [0x7f8f300213f0] 2021-08-28_10:16:28.739680 <gsmtrx:INFO> Command 'CMD 0 SETTSC 2' (ARFCN=0) 2021-08-28_10:16:28.739728 <gsmtrx:INFO> Response 'RSP SETTSC 0 2' (ARFCN=0) 2021-08-28_10:16:28.739865 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETTSC 0 2 to command CMD 0 SETTSC 2 2021-08-28_10:16:28.739912 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETMAXDLY 2 2021-08-28_10:16:28.740976 <gsmtrx:ALL> Handling command 'CMD 0 SETMAXDLY 2' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.741025 <gsmtrx:INFO> Command 'CMD 0 SETMAXDLY 2' (ARFCN=0) 2021-08-28_10:16:28.741074 <gsmtrx:INFO> Response 'RSP SETMAXDLY 0 2' (ARFCN=0) 2021-08-28_10:16:28.741149 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETMAXDLY 0 2 to command CMD 0 SETMAXDLY 2 2021-08-28_10:16:28.741197 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETRXGAIN 0 2021-08-28_10:16:28.742266 <gsmtrx:ALL> Handling command 'CMD 0 SETRXGAIN 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.743415 <gsmtrx:INFO> Command 'CMD 0 SETRXGAIN 0' (ARFCN=0) 2021-08-28_10:16:28.743479 <gsmtrx:INFO> Response 'RSP SETRXGAIN 0 0' (ARFCN=0) 2021-08-28_10:16:28.743568 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETRXGAIN 0 0 to command CMD 0 SETRXGAIN 0 2021-08-28_10:16:28.743616 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 POWERON 2021-08-28_10:16:28.744675 <gsmtrx:ALL> Handling command 'CMD 0 POWERON' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.744720 <gsmtrx:INFO> Starting radio [0x7f8f300213f0] 2021-08-28_10:16:28.766033 <gsmtrx:NOTE> Transceiver State changed PowerOff -> PowerOn [0x7f8f300213f0] 2021-08-28_10:16:28.766142 <gsmtrx:INFO> Command 'CMD 0 POWERON' (ARFCN=0) 2021-08-28_10:16:28.766217 <gsmtrx:INFO> Response 'RSP POWERON 0' (ARFCN=0) 2021-08-28_10:16:28.766339 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP POWERON 0 to command CMD 0 POWERON 2021-08-28_10:16:28.766395 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETPOWER 0 2021-08-28_10:16:28.767438 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 0' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 410 (missed by 337) 2021-08-28_10:16:28.768012 <gsmtrx:INFO> Set Tx gain=0 power_scaling=1 [0x7f8f300213f0] 2021-08-28_10:16:28.768056 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 0' (ARFCN=0) 2021-08-28_10:16:28.768102 <gsmtrx:INFO> Response 'RSP SETPOWER 0 0' (ARFCN=0) 2021-08-28_10:16:28.768165 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETPOWER 0 0 to command CMD 0 SETPOWER 0 2021-08-28_10:16:28.768204 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETSLOT 0 5 2021-08-28_10:16:28.769247 <gsmtrx:ALL> Handling command 'CMD 0 SETSLOT 0 5' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.769276 <gsmtrx:ALL> ARFCN[0]: Slot 0 type set to 5 'V' [0x7f8f3001c110] 2021-08-28_10:16:28.769295 <gsmtrx:ALL> ARFCN[0]: Slot 0 burst type changed None -> Check [0x7f8f3001c110] 2021-08-28_10:16:28.769319 <gsmtrx:INFO> Command 'CMD 0 SETSLOT 0 5' (ARFCN=0) 2021-08-28_10:16:28.769352 <gsmtrx:INFO> Response 'RSP SETSLOT 0 0 5' (ARFCN=0) 2021-08-28_10:16:28.769400 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETSLOT 0 0 5 to command CMD 0 SETSLOT 0 5 2021-08-28_10:16:28.769442 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.770551 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.770624 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.770722 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.770860 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.770969 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.772067 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.772125 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.772174 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.772254 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.772358 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.773446 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.773505 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.773591 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.773690 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.773967 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.775080 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.775136 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.775177 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.775265 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.775379 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.776475 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.776533 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.776583 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.776662 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.776780 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.777855 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.777893 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.777921 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.777977 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.778417 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.779529 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.779587 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.779631 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.779712 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.779923 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.781011 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.781061 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.781099 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.781195 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.781489 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.782575 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.782615 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.782651 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.782744 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.782901 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.784117 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.784158 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.784195 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.784273 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.784513 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.785601 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.785638 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.785673 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.785751 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.785918 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.787004 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.787033 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.787062 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.787128 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.787313 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.788387 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.788422 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.788466 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.788548 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.788692 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.789758 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.789801 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:16:28.789902 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:16:28.789981 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:16:28.790175 <mbts:NOTE> proc 19170 GSMConfig.cpp:532:createCombinationI: thread 140433301886784: Configuring combination I on C0T1 2021-08-28_10:16:28.790204 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETSLOT 1 1 2021-08-28_10:16:28.791352 <gsmtrx:ALL> Handling command 'CMD 0 SETSLOT 1 1' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.791411 <gsmtrx:ALL> ARFCN[0]: Slot 1 type set to 1 'I' [0x7f8f3001c110] 2021-08-28_10:16:28.791429 <gsmtrx:ALL> ARFCN[0]: Slot 1 burst type changed None -> Normal [0x7f8f3001c110] 2021-08-28_10:16:28.791446 <gsmtrx:INFO> Command 'CMD 0 SETSLOT 1 1' (ARFCN=0) 2021-08-28_10:16:28.791498 <gsmtrx:INFO> Response 'RSP SETSLOT 0 1 1' (ARFCN=0) 2021-08-28_10:16:28.791600 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETSLOT 0 1 1 to command CMD 0 SETSLOT 1 1 2021-08-28_10:16:28.791824 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 1 2021-08-28_10:16:28.792895 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 1' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.792943 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 1' (ARFCN=0) 2021-08-28_10:16:28.792982 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 1' (ARFCN=0) 2021-08-28_10:16:28.793042 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 1 to command CMD 0 NOHANDOVER 1 2021-08-28_10:16:28.793195 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 1 2021-08-28_10:16:28.794267 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 1' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.794304 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 1' (ARFCN=0) 2021-08-28_10:16:28.794339 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 1' (ARFCN=0) 2021-08-28_10:16:28.794395 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 1 to command CMD 0 NOHANDOVER 1 2021-08-28_10:16:28.794524 <mbts:NOTE> proc 19170 GSMConfig.cpp:532:createCombinationI: thread 140433301886784: Configuring combination I on C0T2 2021-08-28_10:16:28.794570 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETSLOT 2 1 2021-08-28_10:16:28.795614 <gsmtrx:ALL> Handling command 'CMD 0 SETSLOT 2 1' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.795652 <gsmtrx:ALL> ARFCN[0]: Slot 2 type set to 1 'I' [0x7f8f3001c110] 2021-08-28_10:16:28.795671 <gsmtrx:ALL> ARFCN[0]: Slot 2 burst type changed None -> Normal [0x7f8f3001c110] 2021-08-28_10:16:28.795688 <gsmtrx:INFO> Command 'CMD 0 SETSLOT 2 1' (ARFCN=0) 2021-08-28_10:16:28.795724 <gsmtrx:INFO> Response 'RSP SETSLOT 0 2 1' (ARFCN=0) 2021-08-28_10:16:28.795800 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETSLOT 0 2 1 to command CMD 0 SETSLOT 2 1 2021-08-28_10:16:28.795992 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 2 2021-08-28_10:16:28.797068 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 2' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.797107 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 2' (ARFCN=0) 2021-08-28_10:16:28.797141 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 2' (ARFCN=0) 2021-08-28_10:16:28.797198 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 2 to command CMD 0 NOHANDOVER 2 2021-08-28_10:16:28.797332 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 2 2021-08-28_10:16:28.798405 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 2' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.798439 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 2' (ARFCN=0) 2021-08-28_10:16:28.798471 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 2' (ARFCN=0) 2021-08-28_10:16:28.798524 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 2 to command CMD 0 NOHANDOVER 2 2021-08-28_10:16:28.798656 <mbts:NOTE> proc 19170 GSMConfig.cpp:532:createCombinationI: thread 140433301886784: Configuring combination I on C0T3 2021-08-28_10:16:28.798684 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETSLOT 3 1 2021-08-28_10:16:28.799787 <gsmtrx:ALL> Handling command 'CMD 0 SETSLOT 3 1' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.799841 <gsmtrx:ALL> ARFCN[0]: Slot 3 type set to 1 'I' [0x7f8f3001c110] 2021-08-28_10:16:28.799860 <gsmtrx:ALL> ARFCN[0]: Slot 3 burst type changed None -> Normal [0x7f8f3001c110] 2021-08-28_10:16:28.799877 <gsmtrx:INFO> Command 'CMD 0 SETSLOT 3 1' (ARFCN=0) 2021-08-28_10:16:28.799912 <gsmtrx:INFO> Response 'RSP SETSLOT 0 3 1' (ARFCN=0) 2021-08-28_10:16:28.799975 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETSLOT 0 3 1 to command CMD 0 SETSLOT 3 1 2021-08-28_10:16:28.800295 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 3 2021-08-28_10:16:28.801386 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 3' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.801419 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 3' (ARFCN=0) 2021-08-28_10:16:28.801453 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 3' (ARFCN=0) 2021-08-28_10:16:28.801517 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 3 to command CMD 0 NOHANDOVER 3 2021-08-28_10:16:28.801702 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 3 2021-08-28_10:16:28.802803 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 3' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.802863 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 3' (ARFCN=0) 2021-08-28_10:16:28.802945 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 3' (ARFCN=0) 2021-08-28_10:16:28.803066 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 3 to command CMD 0 NOHANDOVER 3 2021-08-28_10:16:28.803261 <mbts:NOTE> proc 19170 GSMConfig.cpp:532:createCombinationI: thread 140433301886784: Configuring combination I on C0T4 2021-08-28_10:16:28.803311 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETSLOT 4 1 2021-08-28_10:16:28.804364 <gsmtrx:ALL> Handling command 'CMD 0 SETSLOT 4 1' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.804423 <gsmtrx:ALL> ARFCN[0]: Slot 4 type set to 1 'I' [0x7f8f3001c110] 2021-08-28_10:16:28.804458 <gsmtrx:ALL> ARFCN[0]: Slot 4 burst type changed None -> Normal [0x7f8f3001c110] 2021-08-28_10:16:28.804509 <gsmtrx:INFO> Command 'CMD 0 SETSLOT 4 1' (ARFCN=0) 2021-08-28_10:16:28.804574 <gsmtrx:INFO> Response 'RSP SETSLOT 0 4 1' (ARFCN=0) 2021-08-28_10:16:28.804709 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETSLOT 0 4 1 to command CMD 0 SETSLOT 4 1 2021-08-28_10:16:28.804907 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 4 2021-08-28_10:16:28.805982 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 4' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.806042 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 4' (ARFCN=0) 2021-08-28_10:16:28.806097 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 4' (ARFCN=0) 2021-08-28_10:16:28.806185 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 4 to command CMD 0 NOHANDOVER 4 2021-08-28_10:16:28.806468 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 4 2021-08-28_10:16:28.807554 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 4' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.807649 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 4' (ARFCN=0) 2021-08-28_10:16:28.807739 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 4' (ARFCN=0) 2021-08-28_10:16:28.807870 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 4 to command CMD 0 NOHANDOVER 4 2021-08-28_10:16:28.808066 <mbts:NOTE> proc 19170 GSMConfig.cpp:532:createCombinationI: thread 140433301886784: Configuring combination I on C0T5 2021-08-28_10:16:28.808130 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETSLOT 5 1 2021-08-28_10:16:28.809150 <gsmtrx:ALL> Handling command 'CMD 0 SETSLOT 5 1' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.809191 <gsmtrx:ALL> ARFCN[0]: Slot 5 type set to 1 'I' [0x7f8f3001c110] 2021-08-28_10:16:28.809216 <gsmtrx:ALL> ARFCN[0]: Slot 5 burst type changed None -> Normal [0x7f8f3001c110] 2021-08-28_10:16:28.809238 <gsmtrx:INFO> Command 'CMD 0 SETSLOT 5 1' (ARFCN=0) 2021-08-28_10:16:28.809278 <gsmtrx:INFO> Response 'RSP SETSLOT 0 5 1' (ARFCN=0) 2021-08-28_10:16:28.809351 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETSLOT 0 5 1 to command CMD 0 SETSLOT 5 1 2021-08-28_10:16:28.809537 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 5 2021-08-28_10:16:28.810602 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 5' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.810644 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 5' (ARFCN=0) 2021-08-28_10:16:28.810691 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 5' (ARFCN=0) 2021-08-28_10:16:28.810789 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 5 to command CMD 0 NOHANDOVER 5 2021-08-28_10:16:28.810936 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 5 2021-08-28_10:16:28.812034 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 5' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.812074 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 5' (ARFCN=0) 2021-08-28_10:16:28.812128 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 5' (ARFCN=0) 2021-08-28_10:16:28.812220 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 5 to command CMD 0 NOHANDOVER 5 2021-08-28_10:16:28.812432 <mbts:NOTE> proc 19170 GSMConfig.cpp:532:createCombinationI: thread 140433301886784: Configuring combination I on C0T6 2021-08-28_10:16:28.812464 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETSLOT 6 1 2021-08-28_10:16:28.813541 <gsmtrx:ALL> Handling command 'CMD 0 SETSLOT 6 1' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.813586 <gsmtrx:ALL> ARFCN[0]: Slot 6 type set to 1 'I' [0x7f8f3001c110] 2021-08-28_10:16:28.813614 <gsmtrx:ALL> ARFCN[0]: Slot 6 burst type changed None -> Normal [0x7f8f3001c110] 2021-08-28_10:16:28.813635 <gsmtrx:INFO> Command 'CMD 0 SETSLOT 6 1' (ARFCN=0) 2021-08-28_10:16:28.813677 <gsmtrx:INFO> Response 'RSP SETSLOT 0 6 1' (ARFCN=0) 2021-08-28_10:16:28.813759 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETSLOT 0 6 1 to command CMD 0 SETSLOT 6 1 2021-08-28_10:16:28.814032 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 6 2021-08-28_10:16:28.815131 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 6' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.815208 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 6' (ARFCN=0) 2021-08-28_10:16:28.815262 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 6' (ARFCN=0) 2021-08-28_10:16:28.815348 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 6 to command CMD 0 NOHANDOVER 6 2021-08-28_10:16:28.815596 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 6 2021-08-28_10:16:28.816717 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 6' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.816783 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 6' (ARFCN=0) 2021-08-28_10:16:28.816829 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 6' (ARFCN=0) 2021-08-28_10:16:28.816926 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 6 to command CMD 0 NOHANDOVER 6 2021-08-28_10:16:28.817155 <mbts:NOTE> proc 19170 GSMConfig.cpp:532:createCombinationI: thread 140433301886784: Configuring combination I on C0T7 2021-08-28_10:16:28.817185 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETSLOT 7 1 2021-08-28_10:16:28.818248 <gsmtrx:ALL> Handling command 'CMD 0 SETSLOT 7 1' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.818285 <gsmtrx:ALL> ARFCN[0]: Slot 7 type set to 1 'I' [0x7f8f3001c110] 2021-08-28_10:16:28.818311 <gsmtrx:ALL> ARFCN[0]: Slot 7 burst type changed None -> Normal [0x7f8f3001c110] 2021-08-28_10:16:28.818335 <gsmtrx:INFO> Command 'CMD 0 SETSLOT 7 1' (ARFCN=0) 2021-08-28_10:16:28.818380 <gsmtrx:INFO> Response 'RSP SETSLOT 0 7 1' (ARFCN=0) 2021-08-28_10:16:28.818456 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETSLOT 0 7 1 to command CMD 0 SETSLOT 7 1 2021-08-28_10:16:28.818717 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 7 2021-08-28_10:16:28.819883 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 7' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.819949 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 7' (ARFCN=0) 2021-08-28_10:16:28.819994 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 7' (ARFCN=0) 2021-08-28_10:16:28.820061 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 7 to command CMD 0 NOHANDOVER 7 2021-08-28_10:16:28.820215 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 NOHANDOVER 7 2021-08-28_10:16:28.821314 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 7' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:28.821362 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 7' (ARFCN=0) 2021-08-28_10:16:28.821410 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 7' (ARFCN=0) 2021-08-28_10:16:28.821490 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP NOHANDOVER 0 7 to command CMD 0 NOHANDOVER 7 2021-08-28_10:16:28.821657 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD STATISTICS ON 2021-08-28_10:16:28.822765 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP STATISTICS 0 to command CMD STATISTICS ON 2021-08-28_10:16:28.822804 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 command CMD 0 SETPOWER 10 2021-08-28_10:16:28.823855 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 10' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 310 (missed by 237) 2021-08-28_10:16:28.824495 <gsmtrx:INFO> Set Tx gain=0 power_scaling=0.316228 [0x7f8f300213f0] 2021-08-28_10:16:28.824547 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 10' (ARFCN=0) 2021-08-28_10:16:28.824594 <gsmtrx:INFO> Response 'RSP SETPOWER 0 10' (ARFCN=0) 2021-08-28_10:16:28.824678 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433301886784: this:0x55e9810835c0 response RSP SETPOWER 0 10 to command CMD 0 SETPOWER 10 2021-08-28_10:16:29.076248 <mbts:MILD> proc 19170 iputils.cpp:456:ip_finddns: thread 140433301886784: GGSN: DNS servers: 127.0.0.53 0.0.0.0 RTNETLINK answers: File exists 2021-08-28_10:16:29.518752 <cpuload:NOTE> Updating CPU core number from 1 to 8 MBTS ready 2021-08-28_10:16:29.579423 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: RadioReady Info: 0 ----- 2021-08-28_10:16:29.579461 <ybts:NOTE> YBTSDriver State changed Running -> RadioUp 2021-08-28_10:16:32.806910 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433261487872: this:0x55e9810835c0 command CMD 0 SETSLOT 1 10 2021-08-28_10:16:32.808026 <gsmtrx:ALL> Handling command 'CMD 0 SETSLOT 1 10' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:32.808063 <gsmtrx:ALL> ARFCN[0]: Slot 1 type set to 10 'IGPRS' [0x7f8f3001c110] 2021-08-28_10:16:32.808078 <gsmtrx:INFO> Command 'CMD 0 SETSLOT 1 10' (ARFCN=0) 2021-08-28_10:16:32.808114 <gsmtrx:INFO> Response 'RSP SETSLOT 0 1 10' (ARFCN=0) 2021-08-28_10:16:32.808242 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433261487872: this:0x55e9810835c0 response RSP SETSLOT 0 1 10 to command CMD 0 SETSLOT 1 10 2021-08-28_10:16:32.808837 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433261487872: this:0x55e9810835c0 command CMD 0 SETSLOT 2 10 2021-08-28_10:16:32.809920 <gsmtrx:ALL> Handling command 'CMD 0 SETSLOT 2 10' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:32.809949 <gsmtrx:ALL> ARFCN[0]: Slot 2 type set to 10 'IGPRS' [0x7f8f3001c110] 2021-08-28_10:16:32.809961 <gsmtrx:INFO> Command 'CMD 0 SETSLOT 2 10' (ARFCN=0) 2021-08-28_10:16:32.809994 <gsmtrx:INFO> Response 'RSP SETSLOT 0 2 10' (ARFCN=0) 2021-08-28_10:16:32.810077 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433261487872: this:0x55e9810835c0 response RSP SETSLOT 0 2 10 to command CMD 0 SETSLOT 2 10 2021-08-28_10:16:32.810659 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433261487872: this:0x55e9810835c0 command CMD 0 SETSLOT 3 10 2021-08-28_10:16:32.811747 <gsmtrx:ALL> Handling command 'CMD 0 SETSLOT 3 10' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:16:32.811764 <gsmtrx:ALL> ARFCN[0]: Slot 3 type set to 10 'IGPRS' [0x7f8f3001c110] 2021-08-28_10:16:32.811790 <gsmtrx:INFO> Command 'CMD 0 SETSLOT 3 10' (ARFCN=0) 2021-08-28_10:16:32.811837 <gsmtrx:INFO> Response 'RSP SETSLOT 0 3 10' (ARFCN=0) 2021-08-28_10:16:32.811928 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433261487872: this:0x55e9810835c0 response RSP SETSLOT 0 3 10 to command CMD 0 SETSLOT 3 10 2021-08-28_10:16:34.825215 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 command CMD 0 SETPOWER 9 2021-08-28_10:16:34.826304 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 9' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 320 (missed by 247) 2021-08-28_10:16:34.826934 <gsmtrx:INFO> Set Tx gain=0 power_scaling=0.354813 [0x7f8f300213f0] 2021-08-28_10:16:34.826956 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 9' (ARFCN=0) 2021-08-28_10:16:34.826994 <gsmtrx:INFO> Response 'RSP SETPOWER 0 9' (ARFCN=0) 2021-08-28_10:16:34.827072 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 response RSP SETPOWER 0 9 to command CMD 0 SETPOWER 9 2021-08-28_10:16:40.827427 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 command CMD 0 SETPOWER 8 2021-08-28_10:16:40.828530 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 8' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 330 (missed by 257) 2021-08-28_10:16:40.829118 <gsmtrx:INFO> Set Tx gain=0 power_scaling=0.398107 [0x7f8f300213f0] 2021-08-28_10:16:40.829143 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 8' (ARFCN=0) 2021-08-28_10:16:40.829183 <gsmtrx:INFO> Response 'RSP SETPOWER 0 8' (ARFCN=0) 2021-08-28_10:16:40.829273 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 response RSP SETPOWER 0 8 to command CMD 0 SETPOWER 8 2021-08-28_10:16:46.829597 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 command CMD 0 SETPOWER 7 2021-08-28_10:16:46.830686 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 7' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 340 (missed by 267) 2021-08-28_10:16:46.831274 <gsmtrx:INFO> Set Tx gain=0 power_scaling=0.446684 [0x7f8f300213f0] 2021-08-28_10:16:46.831295 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 7' (ARFCN=0) 2021-08-28_10:16:46.831340 <gsmtrx:INFO> Response 'RSP SETPOWER 0 7' (ARFCN=0) 2021-08-28_10:16:46.831412 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 response RSP SETPOWER 0 7 to command CMD 0 SETPOWER 7 2021-08-28_10:16:52.831722 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 command CMD 0 SETPOWER 6 2021-08-28_10:16:52.832836 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 6' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 350 (missed by 277) 2021-08-28_10:16:52.833426 <gsmtrx:INFO> Set Tx gain=0 power_scaling=0.501187 [0x7f8f300213f0] 2021-08-28_10:16:52.833449 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 6' (ARFCN=0) 2021-08-28_10:16:52.833493 <gsmtrx:INFO> Response 'RSP SETPOWER 0 6' (ARFCN=0) 2021-08-28_10:16:52.833564 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 response RSP SETPOWER 0 6 to command CMD 0 SETPOWER 6 2021-08-28_10:16:58.833878 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 command CMD 0 SETPOWER 5 2021-08-28_10:16:58.834967 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 5' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 360 (missed by 287) 2021-08-28_10:16:58.835596 <gsmtrx:INFO> Set Tx gain=0 power_scaling=0.562341 [0x7f8f300213f0] 2021-08-28_10:16:58.835619 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 5' (ARFCN=0) 2021-08-28_10:16:58.835664 <gsmtrx:INFO> Response 'RSP SETPOWER 0 5' (ARFCN=0) 2021-08-28_10:16:58.835746 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 response RSP SETPOWER 0 5 to command CMD 0 SETPOWER 5 2021-08-28_10:17:04.836059 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 command CMD 0 SETPOWER 4 2021-08-28_10:17:04.837163 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 4' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 370 (missed by 297) 2021-08-28_10:17:04.837745 <gsmtrx:INFO> Set Tx gain=0 power_scaling=0.630957 [0x7f8f300213f0] 2021-08-28_10:17:04.837773 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 4' (ARFCN=0) 2021-08-28_10:17:04.837815 <gsmtrx:INFO> Response 'RSP SETPOWER 0 4' (ARFCN=0) 2021-08-28_10:17:04.837908 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 response RSP SETPOWER 0 4 to command CMD 0 SETPOWER 4 2021-08-28_10:17:10.838202 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 command CMD 0 SETPOWER 3 2021-08-28_10:17:10.839273 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 3' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 380 (missed by 307) 2021-08-28_10:17:10.839928 <gsmtrx:INFO> Set Tx gain=0 power_scaling=0.707946 [0x7f8f300213f0] 2021-08-28_10:17:10.839945 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 3' (ARFCN=0) 2021-08-28_10:17:10.839980 <gsmtrx:INFO> Response 'RSP SETPOWER 0 3' (ARFCN=0) 2021-08-28_10:17:10.840053 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 response RSP SETPOWER 0 3 to command CMD 0 SETPOWER 3 2021-08-28_10:17:16.840372 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 command CMD 0 SETPOWER 2 2021-08-28_10:17:16.841474 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 2' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 390 (missed by 317) 2021-08-28_10:17:16.842144 <gsmtrx:INFO> Set Tx gain=0 power_scaling=0.794328 [0x7f8f300213f0] 2021-08-28_10:17:16.842193 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 2' (ARFCN=0) 2021-08-28_10:17:16.842237 <gsmtrx:INFO> Response 'RSP SETPOWER 0 2' (ARFCN=0) 2021-08-28_10:17:16.842351 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 response RSP SETPOWER 0 2 to command CMD 0 SETPOWER 2 2021-08-28_10:17:22.842657 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 command CMD 0 SETPOWER 1 2021-08-28_10:17:22.843745 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 1' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 400 (missed by 327) 2021-08-28_10:17:22.844346 <gsmtrx:INFO> Set Tx gain=0 power_scaling=0.891251 [0x7f8f300213f0] 2021-08-28_10:17:22.844371 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 1' (ARFCN=0) 2021-08-28_10:17:22.844415 <gsmtrx:INFO> Response 'RSP SETPOWER 0 1' (ARFCN=0) 2021-08-28_10:17:22.844497 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 response RSP SETPOWER 0 1 to command CMD 0 SETPOWER 1 2021-08-28_10:17:27.960186 <gsmtrx:INFO> ARFCN[0]: Slot 0. Receiver clipping 1.77552 dB (FN=12825) count=1 [0x7f8f3001c110] 2021-08-28_10:17:27.960610 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433261221632: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:17:27.961687 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:17:27.961713 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:17:27.961753 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:17:27.961834 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433261221632: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:17:27.961956 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433261221632: this:0x55e9810835c0 command CMD 0 NOHANDOVER 0 2021-08-28_10:17:27.963041 <gsmtrx:ALL> Handling command 'CMD 0 NOHANDOVER 0' arfcn=0 [0x7f8f300213f0] 2021-08-28_10:17:27.963061 <gsmtrx:INFO> Command 'CMD 0 NOHANDOVER 0' (ARFCN=0) 2021-08-28_10:17:27.963096 <gsmtrx:INFO> Response 'RSP NOHANDOVER 0 0' (ARFCN=0) 2021-08-28_10:17:27.963157 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433261221632: this:0x55e9810835c0 response RSP NOHANDOVER 0 0 to command CMD 0 NOHANDOVER 0 2021-08-28_10:17:28.270180 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: PhysicalInfo Info: 0 Connection: 1 <PhysicalInfo>TA=0 TE=3.000 UpRSSI=1 TxPwr=33 DnRSSIdBm=-111 time=1630135047.976</PhysicalInfo> ----- 2021-08-28_10:17:28.270341 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: L3Message Info: 0 Connection: 1 <MM> <SkipIndicator>0</SkipIndicator> <NSD>0</NSD> <Message type="LocationUpdatingRequest"> <LocationUpdatingType> <FOR>false</FOR> <LUT>normal-location-updating</LUT> </LocationUpdatingType> <CKSN>0</CKSN> <LAI> <PLMNidentity>28603</PLMNidentity> <LAC>9e9a</LAC> </LAI> <MSClassmark1> <RFPowerCapability>class1</RFPowerCapability> <RevisionLevel>GSM-phase2</RevisionLevel> <Flags>ES-IND</Flags> </MSClassmark1> <MobileIdentity> <TMSI>aa086747</TMSI> </MobileIdentity> </Message> </MM> ----- 2021-08-28_10:17:28.270402 <ybts-signalling:ALL> Added connection (0x7f8f2c004860,1) [0x5645b7de5760] 2021-08-28_10:17:28.270465 <ybts-mm:ALL> Handling LocationUpdatingRequest conn=1: ident=TMSI/aa086747 LAI=28603_9e9a [0x5645b7dd90f0] 2021-08-28_10:17:28.270479 <ybts-mm:ALL> Added empty UE (0x7f8f2c0049a0) [0x5645b7dd90f0] 2021-08-28_10:17:28.270494 <ybts-signalling:ALL> Connection 1 set UE (0x7f8f2c0049a0) TMSI= IMSI= [0x7f8f2c004860] 2021-08-28_10:17:28.270560 <ybts-signalling:INFO> Sending [0x5645b7de5760] ----- Primitive: L3Message Info: 0 Connection: 1 <MM> <Message type="IdentityRequest"> <IdentityType>IMSI</IdentityType> </Message> </MM> ----- 2021-08-28_10:17:28.504520 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: PhysicalInfo Info: 0 Connection: 1 <PhysicalInfo>TA=3 TE=0.000 UpRSSI=1 TxPwr=30 DnRSSIdBm=-111 time=1630135047.963</PhysicalInfo> ----- 2021-08-28_10:17:28.504609 <mbts:NOTE> proc 19170 Sgsn.cpp:1188:handleGprsSuspensionRequest: thread 140433282365184: 10:17:28.5,2989:Received GPRS suspension request for unknown TLLI=0xa6156a4f 2021-08-28_10:17:28.504641 <mbts:NOTE> proc 19170 DCCHDispatch.cpp:82:connDispatchRR: thread 140433282365184: not handled GPRS suspension request on connection 1 2021-08-28_10:17:28.844849 <mbts:NOTE> proc 19170 TRXManager.cpp:127:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 command CMD 0 SETPOWER 0 2021-08-28_10:17:28.845937 <gsmtrx:ALL> Handling command 'CMD 0 SETPOWER 0' arfcn=0 [0x7f8f300213f0] [WARNING @ host/libraries/libbladeRF/src/board/bladerf1/bladerf1.c:1615] set_tx_gain: unable to achieve requested gain 410 (missed by 337) 2021-08-28_10:17:28.846615 <gsmtrx:INFO> Set Tx gain=0 power_scaling=1 [0x7f8f300213f0] 2021-08-28_10:17:28.846636 <gsmtrx:INFO> Command 'CMD 0 SETPOWER 0' (ARFCN=0) 2021-08-28_10:17:28.846672 <gsmtrx:INFO> Response 'RSP SETPOWER 0 0' (ARFCN=0) 2021-08-28_10:17:28.846752 <mbts:NOTE> proc 19170 TRXManager.cpp:153:sendCommandPacket: thread 140433262929664: this:0x55e9810835c0 response RSP SETPOWER 0 0 to command CMD 0 SETPOWER 0 2021-08-28_10:17:28.975349 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: PhysicalInfo Info: 0 Connection: 1 <PhysicalInfo>TA=3 TE=0.000 UpRSSI=1 TxPwr=30 DnRSSIdBm=-111 time=1630135047.963</PhysicalInfo> ----- 2021-08-28_10:17:28.975475 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: L3Message Info: 0 Connection: 1 <MM> <SkipIndicator>0</SkipIndicator> <NSD>1</NSD> <Message type="IdentityResponse"> <MobileIdentity> <IMSI>286038110336712</IMSI> </MobileIdentity> </Message> </MM> ----- 2021-08-28_10:17:28.975522 <ybts-mm:ALL> UE (0x7f8f2c0049a0) IMSI set to 286038110336712 on conn=1 [0x5645b7dd90f0] 2021-08-28_10:17:28.975564 <ybts-signalling:INFO> Sending [0x5645b7de5760] ----- Primitive: L3Message Info: 0 Connection: 1 <MM> <Message type="IdentityRequest"> <IdentityType>IMEI</IdentityType> </Message> </MM> ----- 2021-08-28_10:17:29.682454 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: PhysicalInfo Info: 0 Connection: 1 <PhysicalInfo>TA=3 TE=0.000 UpRSSI=-11 TxPwr=14 DnRSSIdBm=-78 time=1630135048.847</PhysicalInfo> ----- 2021-08-28_10:17:29.682549 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: L3Message Info: 0 Connection: 1 <MM> <SkipIndicator>0</SkipIndicator> <NSD>0</NSD> <Message type="IdentityResponse"> <MobileIdentity> <IMEI>123456789101112</IMEI> </MobileIdentity> </Message> </MM> ----- 2021-08-28_10:17:29.682722 <ybts:ALL> Started location updating thread for (0x7f8f2c0049a0) TMSI= IMSI=286038110336712 [0x7f8f2c002f60] 2021-08-28_10:17:29.683085 <nipc:INFO> Got user.register for imsi='286038110336712', tmsi='007b0002' 2021-08-28_10:17:29.684322 <nipc:INFO> Registered imsi 286038110336712 with number 900336712 2021-08-28_10:17:29.684372 <ybts:ALL> Location updating thread for (0x7f8f2c0049a0) TMSI= IMSI=286038110336712 terminated [0x7f8f2c002f60] 2021-08-28_10:17:29.684392 <ybts-mm:ALL> UE (0x7f8f2c0049a0) registered TMSI '' -> '007b0002', IMSI '286038110336712' -> '286038110336712' conn=1 [0x5645b7dd90f0] 2021-08-28_10:17:29.684406 <ybts-mm:ALL> UE (0x7f8f2c0049a0) TMSI=007b0002 IMSI=286038110336712 register succeeded [0x5645b7dd90f0] 2021-08-28_10:17:29.684499 <ybts-signalling:INFO> Sending [0x5645b7de5760] ----- Primitive: L3Message Info: 0 Connection: 1 <MM> <Message type="LocationUpdatingAccept"> <LAI> <PLMNidentity>28607</PLMNidentity> <LAC>03e8</LAC> </LAI> <MobileIdentity> <TMSI>007b0002</TMSI> </MobileIdentity> </Message> </MM> ----- 2021-08-28_10:17:30.387701 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: PhysicalInfo Info: 0 Connection: 1 <PhysicalInfo>TA=3 TE=0.000 UpRSSI=-16 TxPwr=6 DnRSSIdBm=-79 time=1630135049.848</PhysicalInfo> ----- 2021-08-28_10:17:30.387834 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: L3Message Info: 0 Connection: 1 <MM> <SkipIndicator>0</SkipIndicator> <NSD>1</NSD> <Message type="TMSIReallocationComplete"/> </MM> ----- 2021-08-28_10:17:30.387877 <ybts-signalling:ALL> Releasing connection (0x7f8f2c004860,1) [0x5645b7de5760] 2021-08-28_10:17:30.387896 <ybts-signalling:INFO> Sending [0x5645b7de5760] ----- Primitive: ConnRelease Info: 0 Connection: 1 ----- 2021-08-28_10:17:31.587940 <gsmtrx:INFO> ARFCN[0]: Slot 0. Receiver clipping 1.66502 dB (FN=13611) count=22 [0x7f8f3001c110] 2021-08-28_10:17:31.848398 <gsmtrx:INFO> ARFCN[0]: Slot 2. Receiver clipping 1.23977 dB (FN=13667) count=1 [0x7f8f3001c110] 2021-08-28_10:17:31.965776 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: GprsAttachReq Info: 0 Connection: 8193 <GprsAttach> <tlli>a6156a4f</tlli> <ptmsi>e6156a4f</ptmsi> <authenticated>false</authenticated> <pdps>0000</pdps> </GprsAttach> ----- 2021-08-28_10:17:31.965830 <ybts-signalling:ALL> Added GPRS connection (0x7f8f2c0017b0,8193) [0x5645b7de5760] 2021-08-28_10:17:31.965898 <ybts/ps/1:ALL> Created ConnID=8193 [0x7f8f2c0054b0] 2021-08-28_10:17:31.966605 <INFO> Could not route gprs to 'sgsn' in context 'default', wasted 200 usec 2021-08-28_10:17:31.966679 <ybts/ps/1:MILD> Call rejected error='noroute' reason='No route to call target' [0x7f8f2c0054b0] 2021-08-28_10:17:31.966703 <ybts/ps/1:INFO> Connection continuing locally in mbts 2021-08-28_10:17:31.966723 <ybts-signalling:INFO> Sending [0x5645b7de5760] ----- Primitive: GprsAttachLBO Info: 0 Connection: 8193 ----- 2021-08-28_10:17:31.966798 <ybts/ps/1:ALL> Destroyed ConnID=8193 [0x7f8f2c0054b0] 2021-08-28_10:17:35.401030 <gsmtrx:INFO> ARFCN[0]: Slot 0. Receiver clipping 2.02712 dB (FN=14437) count=1 [0x7f8f3001c110] 2021-08-28_10:17:37.047908 <gsmtrx:INFO> ARFCN[0]: Slot 0. Receiver clipping 0.752546 dB (FN=14794) count=1 [0x7f8f3001c110] 2021-08-28_10:17:37.505652 <gsmtrx:INFO> ARFCN[0]: Slot 2. Receiver clipping 1.37562 dB (FN=14893) count=4 [0x7f8f3001c110] 2021-08-28_10:17:54.184294 <gsmtrx:INFO> ARFCN[0]: Slot 0. Receiver clipping 2.54916 dB (FN=18507) count=1 [0x7f8f3001c110] 2021-08-28_10:18:01.000265 <ybts-signalling:ALL> Removing released connection 1 [0x5645b7de5760] 2021-08-28_10:18:01.000301 <ybts-mm:ALL> Removed UE (0x7f8f2c0049a0): destroyed [0x5645b7dd90f0] 2021-08-28_10:18:01.000315 <ybts:ALL> UE destroyed [0x7f8f2c0049a0] 2021-08-28_10:18:08.242672 <gsmtrx:INFO> ARFCN[0]: Slot 0. Receiver clipping 1.97137 dB (FN=21553) count=1 [0x7f8f3001c110] 2021-08-28_10:18:36.411710 <gsmtrx:INFO> ARFCN[0]: Slot 0. Receiver clipping 1.57753 dB (FN=27656) count=1 [0x7f8f3001c110] 2021-08-28_10:18:51.965002 <gsmtrx:INFO> ARFCN[0]: Slot 0. Receiver clipping 1.90446 dB (FN=31026) count=1 [0x7f8f3001c110] 2021-08-28_10:18:56.607395 <gsmtrx:INFO> ARFCN[0]: Slot 0. Receiver clipping 1.3021 dB (FN=32032) count=1 [0x7f8f3001c110] 2021-08-28_10:19:10.684454 <gsmtrx:INFO> ARFCN[0]: Slot 0. Receiver clipping 1.23179 dB (FN=35082) count=1 [0x7f8f3001c110] 2021-08-28_10:19:15.028469 <gsmtrx:INFO> ARFCN[0]: Slot 0. Receiver clipping 0.99945 dB (FN=36023) count=1 [0x7f8f3001c110] 2021-08-28_10:21:21.437401 <bladerf/1:NOTE> Read timestamp in the future by 117 at 634123750 [0x7f8f300011d0] 2021-08-28_10:21:21.437779 <bladerf/1:FAIL> Read timestamp in the past by 388 at 634125117 [0x7f8f300011d0] 2021-08-28_10:21:21.438188 <bladerf/1:NOTE> Read timestamp in the future by 474 at 634125117 [0x7f8f300011d0] 2021-08-28_10:21:21.438606 <bladerf/1:FAIL> Read timestamp in the past by 201 at 634126724 [0x7f8f300011d0] 2021-08-28_10:21:21.439027 <bladerf/1:NOTE> Read timestamp in the future by 714 at 634126724 [0x7f8f300011d0] 2021-08-28_10:21:21.439422 <bladerf/1:NOTE> Read timestamp in the future by 68 at 634128214 [0x7f8f300011d0] 2021-08-28_10:21:21.439833 <bladerf/1:NOTE> Read timestamp in the future by 361 at 634128818 [0x7f8f300011d0] 2021-08-28_10:21:21.440231 <bladerf/1:FAIL> Read timestamp in the past by 302 at 634130361 [0x7f8f300011d0] 2021-08-28_10:21:21.440634 <bladerf/1:NOTE> Read timestamp in the future by 525 at 634130361 [0x7f8f300011d0] 2021-08-28_10:21:21.440873 <bladerf/1:FAIL> Read timestamp in the past by 380 at 634131775 [0x7f8f300011d0] 2021-08-28_10:21:21.441290 <bladerf/1:NOTE> Read timestamp in the future by 570 at 634131775 [0x7f8f300011d0] 2021-08-28_10:21:21.441518 <bladerf/1:FAIL> Read timestamp in the past by 233 at 634133070 [0x7f8f300011d0] 2021-08-28_10:21:21.441922 <bladerf/1:NOTE> Read timestamp in the future by 646 at 634133070 [0x7f8f300011d0] 2021-08-28_10:21:21.442148 <bladerf/1:FAIL> Read timestamp in the past by 240 at 634134396 [0x7f8f300011d0] 2021-08-28_10:21:21.442532 <bladerf/1:NOTE> Read timestamp in the future by 639 at 634134396 [0x7f8f300011d0] 2021-08-28_10:21:21.442752 <bladerf/1:FAIL> Read timestamp in the past by 147 at 634135639 [0x7f8f300011d0] 2021-08-28_10:21:21.443156 <bladerf/1:NOTE> Read timestamp in the future by 750 at 634135639 [0x7f8f300011d0] 2021-08-28_10:21:21.443382 <bladerf/1:FAIL> Read timestamp in the past by 136 at 634137000 [0x7f8f300011d0] 2021-08-28_10:21:21.443766 <bladerf/1:NOTE> Read timestamp in the future by 708 at 634137000 [0x7f8f300011d0] 2021-08-28_10:21:21.444014 <bladerf/1:NOTE> Read timestamp in the future by 9 at 634138208 [0x7f8f300011d0] 2021-08-28_10:21:21.444480 <bladerf/1:NOTE> Read timestamp in the future by 390 at 634138759 [0x7f8f300011d0] 2021-08-28_10:21:21.444930 <bladerf/1:FAIL> Read timestamp in the past by 203 at 634140390 [0x7f8f300011d0] 2021-08-28_10:21:21.445367 <bladerf/1:NOTE> Read timestamp in the future by 746 at 634140390 [0x7f8f300011d0] 2021-08-28_10:21:21.445596 <bladerf/1:FAIL> Read timestamp in the past by 350 at 634141996 [0x7f8f300011d0] 2021-08-28_10:21:21.446032 <bladerf/1:NOTE> Read timestamp in the future by 582 at 634141996 [0x7f8f300011d0] 2021-08-28_10:21:21.446264 <bladerf/1:NOTE> Read timestamp in the future by 41 at 634143082 [0x7f8f300011d0] 2021-08-28_10:21:21.446675 <bladerf/1:NOTE> Read timestamp in the future by 211 at 634143791 [0x7f8f300011d0] 2021-08-28_10:21:21.447085 <bladerf/1:FAIL> Read timestamp in the past by 312 at 634145211 [0x7f8f300011d0] 2021-08-28_10:21:21.447494 <bladerf/1:NOTE> Read timestamp in the future by 550 at 634145211 [0x7f8f300011d0] 2021-08-28_10:21:21.447706 <bladerf/1:FAIL> Read timestamp in the past by 547 at 634146800 [0x7f8f300011d0] 2021-08-28_10:21:21.448093 <bladerf/1:NOTE> Read timestamp in the future by 298 at 634146800 [0x7f8f300011d0] 2021-08-28_10:21:21.448305 <bladerf/1:FAIL> Read timestamp in the past by 243 at 634147798 [0x7f8f300011d0] 2021-08-28_10:21:21.448673 <bladerf/1:NOTE> Read timestamp in the future by 566 at 634147798 [0x7f8f300011d0] 2021-08-28_10:21:21.448881 <bladerf/1:FAIL> Read timestamp in the past by 513 at 634149316 [0x7f8f300011d0] 2021-08-28_10:21:21.449269 <bladerf/1:NOTE> Read timestamp in the future by 332 at 634149316 [0x7f8f300011d0] 2021-08-28_10:21:21.449485 <bladerf/1:FAIL> Read timestamp in the past by 227 at 634150332 [0x7f8f300011d0] 2021-08-28_10:21:21.449858 <bladerf/1:NOTE> Read timestamp in the future by 582 at 634150332 [0x7f8f300011d0] 2021-08-28_10:21:21.450100 <bladerf/1:FAIL> Read timestamp in the past by 461 at 634151832 [0x7f8f300011d0] 2021-08-28_10:21:21.450490 <bladerf/1:NOTE> Read timestamp in the future by 436 at 634151832 [0x7f8f300011d0] 2021-08-28_10:21:21.450720 <bladerf/1:FAIL> Read timestamp in the past by 194 at 634152936 [0x7f8f300011d0] 2021-08-28_10:21:21.451143 <bladerf/1:NOTE> Read timestamp in the future by 738 at 634152936 [0x7f8f300011d0] 2021-08-28_10:21:21.451373 <bladerf/1:FAIL> Read timestamp in the past by 304 at 634154488 [0x7f8f300011d0] 2021-08-28_10:21:21.451384 <gsmtrx:WARN> Too many read errors, last: 0x40 TooEarly [0x7f8f300213f0] 2021-08-28_10:21:21.451422 <gsmtrx:ALL> Sending 'EXITING code=64 operation=radio-read' on clock interface [0x7f8f300213f0] 2021-08-28_10:21:21.451481 <gsmtrx:ALL> Radio device read thread (0x7f8f2806c900) terminated [0x7f8f300213f0] 2021-08-28_10:21:21.451601 <gsmtrx:ALL> Radio device send thread (0x7f8f3002bf70) terminated [0x7f8f300213f0] 2021-08-28_10:21:21.451689 <mbts:NOTE> proc 19170 TRXManager.cpp:296:clockHandler: thread 140433301006080: TRX clock 'EXITING' indication 2021-08-28_10:21:21.451767 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: Stop Info: 3 <Stop> <code>64</code> <operation>radio-read</operation> </Stop> ----- 2021-08-28_10:21:21.451829 <ybts-signalling:NOTE> Peer stop notification 'RadioExiting' code=0x40 (TooEarly) operation=radio-read [0x5645b7de5760] 2021-08-28_10:21:21.451846 <ybts:ALL> Restart scheduled in 1ms [0x7f8f57e66b00] 2021-08-28_10:21:21.451857 <ybts:ALL> Scheduled stop in 0ms 2021-08-28_10:21:21.451867 <ybts-signalling:ALL> Worker thread terminated [0x5645b7de5760] 2021-08-28_10:21:21.452675 <snmpagent:INFO> Dropping message from 127.0.0.1 with wrong community '' 2021-08-28_10:21:21.452720 <snmpagent:ALL> Error processing message [0x7f8f2c001ba0] 2021-08-28_10:21:21.452765 <gsmtrx:ALL> ARFCN[0]: Data socket read thread (0x7f8f2806d1f0) terminated [0x7f8f3001c110] 2021-08-28_10:21:21.453942 <gsmtrx:ALL> ARFCN[2]: Radio input process thread (0x7f8f2806d8e0) terminated [0x7f8f3000f7e0] 2021-08-28_10:21:21.454672 <gsmtrx:ALL> ARFCN[2]: Data socket read thread (0x7f8f2806db30) terminated [0x7f8f3000f7e0] 2021-08-28_10:21:21.454701 <gsmtrx:ALL> ARFCN[3]: Data socket read thread (0x7f8f2806dfd0) terminated [0x7f8f30026500] 2021-08-28_10:21:21.454802 <gsmtrx:ALL> ARFCN[1]: Data socket read thread (0x7f8f2806d690) terminated [0x7f8f3000c2b0] 2021-08-28_10:21:21.455002 <gsmtrx:ALL> ARFCN[0]: Radio input process thread (0x7f8f3002bdb0) terminated [0x7f8f3001c110] 2021-08-28_10:21:21.455770 <gsmtrx:ALL> ARFCN[3]: Radio input process thread (0x7f8f2806dd80) terminated [0x7f8f30026500] 2021-08-28_10:21:21.455814 <gsmtrx:ALL> ARFCN[1]: Radio input process thread (0x7f8f2806d440) terminated [0x7f8f3000c2b0] 2021-08-28_10:21:21.456251 <gsmtrx:ALL> Radio read process thread (0x7f8f3002c100) terminated [0x7f8f300213f0] 2021-08-28_10:21:22.000377 <ybts:ALL> 'shutdown' command result: ----- exiting... ----- 2021-08-28_10:21:22.000409 <ybts:NOTE> Stopping ... 2021-08-28_10:21:22.000440 <mbts:NOTE> proc 19170 OpenBTS.cpp:490:main: thread 140433301886784: MBTS exiting MBTS exiting 2021-08-28_10:21:22.000469 <ybts-signalling:INFO> Stopped [0x5645b7de5760] 2021-08-28_10:21:22.001752 <ybts-media:ALL> Worker thread terminated [0x5645b7de5480] 2021-08-28_10:21:22.005571 <ybts-media:INFO> Stopped [0x5645b7de5480] 2021-08-28_10:21:22.005594 <ybts:NOTE> Peer pid 19170 has not exited - we'll kill it 2021-08-28_10:21:22.107261 <ybts:INFO> Peer pid 19170 terminated 2021-08-28_10:21:22.107305 <ybts-command:INFO> Stopped [0x5645b7de5320] 2021-08-28_10:21:22.109167 <transceiver:ALL> Worker thread terminated [0x5645b7de4e80] 2021-08-28_10:21:22.112419 <transceiver:INFO> Stopped [0x5645b7de4e80] 2021-08-28_10:21:22.116979 <mbts:ALL> Worker thread terminated [0x5645b7de50c0] 2021-08-28_10:21:22.117506 <mbts:INFO> Stopped [0x5645b7de50c0] 2021-08-28_10:21:22.117519 <ybts:NOTE> YBTSDriver State changed RadioUp -> Idle 2021-08-28_10:21:22.117565 <gsmtrx:INFO> Module state changed Running -> Waiting 2021-08-28_10:21:22.117574 <gsmtrx:NOTE> Stopping transceiver: In error 2021-08-28_10:21:22.117583 <gsmtrx:ALL> Stopping [0x7f8f300213f0] 2021-08-28_10:21:22.117592 <gsmtrx:ALL> Sending 'EXITING' on clock interface [0x7f8f300213f0] 2021-08-28_10:21:22.117651 <gsmtrx:NOTE> Transceiver State changed PowerOn -> Idle [0x7f8f300213f0] Transceiver(gsmtrx) status: [0x7f8f300213f0] ----- RadioClock: 507323 63415/3 LastSyncUpper: 507296 63412/0 TxTime: 507343 63417/7 TxBursts: 507327 RxBursts: 507312 ARFCN[0] UplinkLastOutTime: 507312 63414/0 DownlinkLastInTime: 507392 63424/0 RxBursts: 507213 RxDroppedBursts: 477910 LowSNR=477908 LowPeakMin=2 DownlinkInBursts: 47351 (13091/876/14636/15416/836/832/832/832) TxMissSyncOnSend: 4 TxExpiredOnSend: 1 TxExpiredOnRecv: 0 TxFutureOnRecv: 0 TxDupOnRecv: 0 ----- 2021-08-28_10:21:22.117794 <gsmtrx:NOTE> ARFCN[0]: Radio power off. RX: bursts=507213 passed=29303 (5.78%) dropped=477910 (94.22%) (LowSNR=477908 LowPeakMin=2) ellapsed=293sec avg=1731.10 bursts/sec [0x7f8f3001c110] 2021-08-28_10:21:22.118146 <bladerf/1:ALL> Destroying device=((nil)) [0x7f8f300011d0] 2021-08-28_10:21:22.118161 <bladerf/1:ALL> Interface destroyed [0x7f8f300011d0] 2021-08-28_10:21:23.000251 <ybts:NOTE> YBTSDriver State changed Idle -> Starting restart counter 1/10 2021-08-28_10:21:23.000387 <transceiver:ALL> Started worker thread [0x5645b7de4e80] 2021-08-28_10:21:23.000400 <transceiver:INFO> Started [0x5645b7de4e80] 2021-08-28_10:21:23.000448 <mbts:ALL> Started worker thread [0x5645b7de50c0] 2021-08-28_10:21:23.000458 <mbts:INFO> Started [0x5645b7de50c0] 2021-08-28_10:21:23.000483 <ybts-command:INFO> Started [0x5645b7de5320] 2021-08-28_10:21:23.000544 <ybts-signalling:ALL> Started worker thread [0x5645b7de5760] 2021-08-28_10:21:23.000557 <ybts-signalling:INFO> Started [0x5645b7de5760] 2021-08-28_10:21:23.000608 <ybts-media:ALL> Started worker thread [0x5645b7de5480] 2021-08-28_10:21:23.000618 <ybts-media:INFO> Started [0x5645b7de5480] 2021-08-28_10:21:23.000628 <ybts:ALL> Starting peer '/usr/local/lib/yate/server/bts/mbts' '(null)' 2021-08-28_10:21:23.003454 <ybts:INFO> Started peer pid=19303 2021-08-28_10:21:23.003528 <ybts:NOTE> YBTSDriver State changed Starting -> WaitHandshake 2021-08-28_10:21:23.003551 <ybts:ALL> Restart scheduled in 120000ms [0x7f8f57e66b00] MBTS connected to YBTS Yate-BTS MBTS Component Copyright 2008, 2009, 2010 Free Software Foundation, Inc. Copyright 2010 Kestrel Signal Processing, Inc. Copyright 2011, 2012, 2013 Range Networks, Inc. Copyright 2013, 2014 Null Team Impex SRL Copyright 2014 Legba, Inc. "OpenBTS" is a registered trademark of Range Networks, Inc. Contributors: SC Null Team Impex SRL: Paul Chitescu Legba, Inc. David Burgess Range Networks, Inc.: David Burgess, Harvind Samra, Donald Kirker, Doug Brown, Pat Thompson, Kurtis Heimerl Kestrel Signal Processing, Inc.: David Burgess, Harvind Samra, Raffi Sevlian, Roshan Baliga GNU Radio: Johnathan Corgan Others: Anne Kwong, Jacob Appelbaum, Joshua Lackey, Alon Levy Alexander Chemeris, Alberto Escudero-Pascual Incorporated L/GPL libraries and components: libusb, LGPL 2.1, various copyright holders, www.libusb.org Incorporated BSD/MIT-style libraries and components: A5/1 Pedagogical Implementation, Simplified BSD License, Copyright 1998-1999 Marc Briceno, Ian Goldberg, and David Wagner Incorporated public domain libraries and components: sqlite3, released to public domain 15 Sept 2001, www.sqlite.org This program comes with ABSOLUTELY NO WARRANTY. Use of this software may be subject to other legal restrictions, including patent licensing and radio spectrum licensing. All users of this software are expected to comply with applicable regulations and laws. See the LEGAL file in the source code for more information. Release 6.1.1 formal build date Aug 22 2021 rev 2021-08-28_10:21:23.015835 <mbts:NOTE> proc 19303 GSMConfig.cpp:80:regenerateBeacon: thread 139711937922880: regenerating system information messages, changemark 1 Starting MBTS... 2021-08-28_10:21:23.016052 <mbts:NOTE> proc 19303 TRXManager.cpp:127:sendCommandPacket: thread 139711937922880: this:0x55da9ba0b5c0 command CMD RESET 1 2021-08-28_10:21:23.016144 <ybts-signalling:INFO> Received [0x5645b7de5760] ----- Primitive: Handshake Info: 0 ----- 2021-08-28_10:21:23.016166 <ybts:NOTE> YBTSDriver State changed WaitHandshake -> Running 2021-08-28_10:21:23.016186 <ybts-signalling:INFO> Sending [0x5645b7de5760] ----- Primitive: Handshake Info: 0 ----- 2021-08-28_10:21:23.017157 >>> RSP RESET ANSWER 2021-08-28_10:21:23.017224 >>> BrfModule::createIface() 2021-08-28_10:21:23.017255 <bladerf/2:ALL> Interface created [0x7f8f30014370] 2021-08-28_10:21:23.017267 <<< BrfModule::createIface() 2021-08-28_10:21:23.017345 <gsmtrx:ALL> Adjusting parameter arfcns='1' -> 4 [0x7f8f300213f0] 2021-08-28_10:21:23.017708 <gsmtrx:ALL> Initialized [0x7f8f300213f0] ----- ARFCNs=4 oversampling=8 ----- Segmentation fault
The text was updated successfully, but these errors were encountered:
No branches or pull requests
Hi! I have a trouble with bladeRFx40 and YateBTS on Ubuntu 18.04. Yate works normally for a while but it stops working after a few minutes.
Versions info is shown below;
I run the following command;
$ sudo yate -vvvThe device successfully work and I can connect my phone to gsm but after a while, Yate turns itself off with "Segmentation Fault".
All Yate outputs are shown below;
The text was updated successfully, but these errors were encountered: