[ 1375.216019] [b6] CYCLE 1 begin: w=0 s=0 mss=offline
[ 1375.234709] [aurora-modem] === START (conf /tmp/aurora-modem.conf, apn 'internet.beeline.ru', ip-type ipv4)
[ 1375.297963] remoteproc remoteproc0: powering up 4080000.remoteproc
[ 1375.298367] remoteproc remoteproc0: Booting fw image mba.mbn, size 234176
[ 1375.309788] [aurora-modem] STATE OFF -> RMTFS_READY
[ 1375.315202] [aurora-modem] STATE RMTFS_READY -> MPSS_BOOTING
[ 1375.344295] qcom-q6v5-mss 4080000.remoteproc: MBA booted without debug policy, loading mpss
[ 1375.890190] remoteproc remoteproc0: remote processor 4080000.remoteproc is now up
[ 1375.992007] [aurora-modem] MSS running after 0.7s
[ 1375.997726] [aurora-modem] STATE MPSS_BOOTING -> MPSS_RUNNING
[ 1376.487283] wwan wwan0: port wwan0at0 attached
[ 1376.488589] wwan wwan0: port wwan0at1 attached
[ 1376.662910] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 0
[ 1376.662993] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 1
[ 1376.668802] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 2
[ 1376.675649] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 3
[ 1376.682262] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 4
[ 1376.689030] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 5
[ 1376.695806] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 6
[ 1376.702570] bam-dmux 4080000.remoteproc:bam-dmux: Channel already open: 7
[ 1376.709883] wwan wwan0: port wwan0qmi0 attached
[ 1376.844516] [aurora-modem] wwan0qmi0 + wwan0 present after 0.8s; +2 s (JZ02 rpmsg_wwan_ctrl port-race guard, proven start_post)
[ 1379.026118] [aurora-modem] STATE MPSS_RUNNING -> QMI_READY
[ 1379.038307] [aurora-modem] DMS Mode: 'shutting-down' after 0.2s
[ 1379.092461] [aurora-modem] STATE QMI_READY -> SIM_READY
[ 1379.100658] [aurora-modem] UIM card present, USIM app ready after 0.1s
[ 1379.106015] [aurora-modem] SET: qmicli -p -d /dev/wwan0qmi0 --dms-set-operating-mode=online (retried only on DeviceNotReady, <= 30s)
[ 1382.346360] [aurora-modem] DMS online after 3.2s
[ 1382.351578] [aurora-modem] STATE SIM_READY -> RADIO_ONLINE
[ 1386.502145] [aurora-modem] registered: MCC: '250' MNC: '99' Description: 'Beeline' MCC: '250' MNC: '99' after 4.1s
[ 1386.507028] [aurora-modem] STATE RADIO_ONLINE -> REGISTERED
[ 1386.555814] udevd[2164]: starting version 3.2.14
[ 1386.558490] udevd[2164]: specified group 'tty' unknown
[ 1386.559700] udevd[2164]: specified group 'dialout' unknown
[ 1386.564788] udevd[2164]: specified group 'kmem' unknown
[ 1386.570053] udevd[2164]: specified group 'input' unknown
[ 1386.575157] udevd[2164]: specified group 'video' unknown
[ 1386.580747] udevd[2164]: specified group 'audio' unknown
[ 1386.586090] udevd[2164]: specified group 'lp' unknown
[ 1386.591320] udevd[2164]: specified group 'disk' unknown
[ 1386.596294] udevd[2164]: specified group 'cdrom' unknown
[ 1386.627736] udevd[2165]: starting eudev-3.2.14
[ 1386.993495] [aurora-modem] udevd started
[ 1387.021547] [aurora-modem] dbus started
[ 1387.035419] [aurora-modem] polkitd started
[ 1387.054818] [aurora-modem] ModemManager started pid 2210 (log mm-0.log)
[ 1435.780952] [aurora-modem] MM modem 0 detected after 48.7s
[ 1435.884808] [aurora-modem] STATE REGISTERED -> MM_READY
[ 1497.118929] [aurora-modem] FAIL in MM_READY: MM state 'disabled' not registered after 60s
[ 1497.319812] [aurora-modem] rollback: full stop
[ 1497.371332] [aurora-modem] === STOP (from MM_READY: mss=running rmtfs=1913 mm=2210 bam=suspended)
[ 1497.579422] [aurora-modem] wwan links down, addresses/routes removed
[ 1497.591264] [aurora-modem] STATE MM_READY -> WWAN_DOWN
[ 1498.717014] [aurora-modem] ModemManager stopped
[ 1498.755046] [aurora-modem] qmi-proxy stopped
[ 1498.760536] [aurora-modem] STATE WWAN_DOWN -> MM_STOPPED
[ 1498.785958] [aurora-modem] BAM-DMUX suspended after 0.0s
[ 1498.803966] [aurora-modem] SIGTERM rmtfs 1913 (rmtfs stops MSS, then exits)
[ 1498.805372] wwan wwan0: port wwan0at0 disconnected
[ 1498.811333] wwan wwan0: port wwan0at1 disconnected
[ 1498.815155] wwan wwan0: port wwan0qmi0 disconnected
[ 1498.824505] remoteproc remoteproc0: stopped remote processor 4080000.remoteproc
[ 1499.045678] [aurora-modem] MSS offline after 0.2s (rmtfs alive: no)
[ 1499.053764] [aurora-modem] STATE MM_STOPPED -> MPSS_STOPPED
[ 1499.069944] [aurora-modem] rmtfs exited after 0.3s
[ 1499.085757] [aurora-modem] STATE MPSS_STOPPED -> OFF
[ 1499.133871] [aurora-modem] === STOP done rc=0 in 1.8s (mss=offline rmtfs='' mm='' bam=suspended)
[ 1499.134717] [b6] CYCLE 1 start rc=1
[ 1499.378521] [b6] CYCLE 1 DATATEST not-run rc=9
[ 1499.387558] [b6] CYCLE 1 stop rc=0
