[ 2873.006336] [m] CYCLE 1 begin: emmc w=0 s=0 mss=offline rmtfs=''
[ 2873.030830] [aurora-modem] === START (conf /tmp/m.conf, apn 'internet.beeline.ru', ip-type ipv4)
[ 2873.103535] remoteproc remoteproc0: powering up 4080000.remoteproc
[ 2873.103912] remoteproc remoteproc0: Booting fw image mba.mbn, size 234176
[ 2873.116542] [aurora-modem] STATE OFF -> RMTFS_READY
[ 2873.121732] [aurora-modem] STATE RMTFS_READY -> MPSS_BOOTING
[ 2873.148604] qcom-q6v5-mss 4080000.remoteproc: MBA booted without debug policy, loading mpss
[ 2873.692189] remoteproc remoteproc0: remote processor 4080000.remoteproc is now up
[ 2873.792891] [aurora-modem] MSS running after 0.7s
[ 2873.798089] [aurora-modem] STATE MPSS_BOOTING -> MPSS_RUNNING
[ 2874.257581] wwan wwan0: port wwan0at0 attached
[ 2874.259369] wwan wwan0: port wwan0at1 attached
[ 2874.428267] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 0
[ 2874.428365] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 1
[ 2874.434137] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 2
[ 2874.441010] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 3
[ 2874.447624] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 4
[ 2874.454382] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 5
[ 2874.461152] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 6
[ 2874.467931] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 7
[ 2874.474923] wwan wwan0: port wwan0qmi0 attached
[ 2874.644603] [aurora-modem] wwan0qmi0 + wwan0 present after 0.8s; +2 s (JZ02 rpmsg_wwan_ctrl port-race guard, proven start_post)
[ 2876.825125] [aurora-modem] STATE MPSS_RUNNING -> QMI_READY
[ 2876.836812] [aurora-modem] DMS Mode: 'shutting-down' after 0.2s
[ 2876.892057] [aurora-modem] STATE QMI_READY -> SIM_READY
[ 2876.901819] [aurora-modem] UIM card present, USIM app ready after 0.1s
[ 2876.910181] [aurora-modem] SET: qmicli -p -d /dev/wwan0qmi0 --dms-set-operating-mode=online (retried only on DeviceNotReady, <= 30s)
[ 2880.150699] [aurora-modem] DMS online after 3.2s
[ 2880.156626] [aurora-modem] STATE SIM_READY -> RADIO_ONLINE
[ 2880.476269] [aurora-modem] REG t+0.3s: not-registered-searching / PS detached / none (none, ) - pci= si=/ cl=/
[ 2883.753903] [aurora-modem] REG t+3.6s: not-registered-searching / PS detached / limited (limited-regional, camped) 250-99 pci=55 si=/156465929 cl=7661/156465929
[ 2887.040643] [aurora-modem] REG t+6.9s: registered / PS attached / available (none, ps) 250-99 pci=55 si=7661/156465929 cl=7661/156465929
[ 2887.053664] [aurora-modem] registered: MCC: '250' MNC: '99' Description: 'Beeline' MCC: '250' MNC: '99' after 6.9s
[ 2887.059346] [aurora-modem] STATE RADIO_ONLINE -> REGISTERED
[ 2887.279448] [aurora-modem] ModemManager started pid 15160 (log mm-3.log)
[ 2935.872772] [aurora-modem] MM modem 0 detected after 48.6s
[ 2935.971190] [aurora-modem] STATE REGISTERED -> MM_READY
[ 2936.163529] [aurora-modem] MM state disabled after 0.2s
[ 2936.309219] [aurora-modem] mmcli -m 0 --simple-connect="apn=internet.beeline.ru,user=beeline,password=***,allowed-auth=pap,ip-type=ipv4"
[ 2947.165690] [aurora-modem] MM state connected, registration: home
[ 2947.246107] [aurora-modem] bearer 1: wwan0 10.42.49.49/30 gw 10.42.49.50 dns 10.10.22.1,194.186.191.1 mtu 1500
[ 2947.304689] [aurora-modem] STATE MM_READY -> BEARER_CONNECTED
[ 2947.316634] [aurora-modem] === START OK in 74.3s (wwan0 10.42.49.49/30, routes: 10.10.22.1 194.186.191.1 77.88.8.8 1.1.1.1 )
[ 2947.318194] [m] CYCLE 1 start rc=0
[ 2953.097263] [m] CYCLE 1 DATATEST PASS dns=1(ya=5.255.255.242 go=142.251.150.119) ping=3+3 http=code=302 https=[code=204 code=200 ](1) if=wwan0 addr=10.42.49.49 rc=0
[ 2953.160604] [aurora-modem] === STOP (from BEARER_CONNECTED: mss=running rmtfs=14565 mm=15160 bam=active)
[ 2953.803558] [aurora-modem] simple-disconnect rc=0 (bearers: 1 )
[ 2953.977846] [aurora-modem] no bearer connected
[ 2953.980188] [aurora-modem] MODEM_STOP_DISABLE=0: no MM disable
[ 2954.067909] [aurora-modem] wwan links down, addresses/routes removed
[ 2954.077320] [aurora-modem] STATE BEARER_CONNECTED -> WWAN_DOWN
[ 2956.757496] [aurora-modem] ModemManager stopped
[ 2956.806835] [aurora-modem] qmi-proxy stopped
[ 2956.812226] [aurora-modem] STATE WWAN_DOWN -> MM_STOPPED
[ 2956.836122] [aurora-modem] BAM-DMUX suspended after 0.0s
[ 2956.862807] wwan wwan0: port wwan0at0 disconnected
[ 2956.863256] wwan wwan0: port wwan0at1 disconnected
[ 2956.863315] [aurora-modem] SIGTERM rmtfs 14565 (rmtfs stops MSS, then exits)
[ 2956.870476] wwan wwan0: port wwan0qmi0 disconnected
[ 2956.884580] remoteproc remoteproc0: stopped remote processor 4080000.remoteproc
[ 2957.109648] [aurora-modem] MSS offline after 0.2s (rmtfs alive: no)
[ 2957.118950] [aurora-modem] STATE MM_STOPPED -> MPSS_STOPPED
[ 2957.134223] [aurora-modem] rmtfs exited after 0.3s
[ 2957.151146] [aurora-modem] STATE MPSS_STOPPED -> OFF
[ 2957.203791] [aurora-modem] === STOP done rc=0 in 4.0s (mss=offline rmtfs='' mm='' bam=suspended)
[ 2957.204796] [m] CYCLE 1 stop rc=0