[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd030]
[    0.000000] Linux version 7.2.7-aurora-bam1 (q@aiaiai) (aarch64-linux-gnu-gcc (Debian 14.2.0-19) 14.2.0, GNU ld (GNU Binutils for Debian) 2.44) #5 SMP PREEMPT Wed Sep 30 04:59:18 +06 2026
[    0.000000] KASLR enabled
[    0.000000] random: crng init done
[    0.000000] Machine model: JZ08AU Aurora (RAM boot BAM1)
[    0.000000] earlycon: msm_serial_dm0 at MMIO 0x00000000078b0000 (options '115200n8')
[    0.000000] printk: legacy bootconsole [msm_serial_dm0] enabled
[    0.000000] printk: debug: ignoring loglevel setting.
[    0.000000] OF: reserved mem: 0x000000008e700000..0x000000008e7fffff (1024 KiB) nomap non-reusable mba
[    0.000000] OF: reserved mem: 0x0000000086000000..0x00000000862fffff (3072 KiB) nomap non-reusable tz-apps@86000000
[    0.000000] OF: reserved mem: 0x0000000086300000..0x00000000863fffff (1024 KiB) nomap non-reusable smem@86300000
[    0.000000] OF: reserved mem: 0x0000000086400000..0x00000000864fffff (1024 KiB) nomap non-reusable hypervisor@86400000
[    0.000000] OF: reserved mem: 0x0000000086500000..0x000000008667ffff (1536 KiB) nomap non-reusable tz@86500000
[    0.000000] OF: reserved mem: 0x0000000086680000..0x00000000866fffff (512 KiB) nomap non-reusable reserved@86680000
[    0.000000] OF: reserved mem: 0x0000000086700000..0x00000000867dffff (896 KiB) nomap non-reusable rmtfs@86700000
[    0.000000] OF: reserved mem: 0x00000000867e0000..0x00000000867fffff (128 KiB) nomap non-reusable rfsa@867e0000
[    0.000000] OF: reserved mem: 0x0000000086800000..0x000000008b5fffff (79872 KiB) nomap non-reusable mpss@86800000
[    0.000000] cma: Reserved 32 MiB at 0x000000009de00000
[    0.000000] psci: probing for conduit method from DT.
[    0.000000] psci: PSCIv1.0 detected in firmware.
[    0.000000] psci: Using standard PSCI v0.2 function IDs
[    0.000000] psci: MIGRATE_INFO_TYPE not supported.
[    0.000000] psci: SMC Calling Convention v1.0
[    0.000000] psci: OSI mode supported.
[    0.000000] psci: [Firmware Bug]: failed to set PC mode: -3
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000080000000-0x000000009fffffff]
[    0.000000]   DMA32    empty
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000080000000-0x0000000085ffffff]
[    0.000000]   node   0: [mem 0x0000000086000000-0x000000008b5fffff]
[    0.000000]   node   0: [mem 0x000000008b600000-0x000000008e6fffff]
[    0.000000]   node   0: [mem 0x000000008e700000-0x000000008e7fffff]
[    0.000000]   node   0: [mem 0x000000008e800000-0x000000009fffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000080000000-0x000000009fffffff]
[    0.000000] percpu: Embedded 19 pages/cpu s48408 r0 d29416 u77824
[    0.000000] pcpu-alloc: s48408 r0 d29416 u77824 alloc=19*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
[    0.000000] Detected VIPT I-cache on CPU0
[    0.000000] CPU features: kernel page table isolation forced ON by KASLR
[    0.000000] CPU features: detected: Kernel page table isolation (KPTI)
[    0.000000] CPU features: detected: ARM erratum 843419
[    0.000000] CPU features: detected: ARM erratum 845719
[    0.000000] CPU features: detected: ARM errata 826319, 827319, 824069, or 819472
[    0.000000] alternatives: applying boot alternatives
[    0.000000] Kernel command line: earlycon console=ttyMSM0,115200n8 ignore_loglevel loglevel=8 rdinit=/init
[    0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes
[    0.000000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
[    0.000000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 0MB
[    0.000000] software IO TLB: area num 4.
[    0.000000] software IO TLB: SWIOTLB bounce buffer size roundup to 1MB
[    0.000000] software IO TLB: mapped [mem 0x000000009d480000-0x000000009d580000] (1MB)
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 131072
[    0.000000] mem auto-init: stack:all(zero), heap alloc:off, heap free:off
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] rcu: Preemptible hierarchical RCU implementation.
[    0.000000] rcu: 	RCU event tracing is enabled.
[    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] Root IRQ handler: gic_handle_irq
[    0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[    0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    0.000000] arch_timer: cp15 timer running at 19.20MHz (virt).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
[    0.000000] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
[    0.010988] Console: colour dummy device 80x25
[    0.018715] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=76800)
[    0.023191] pid_max: default: 32768 minimum: 301
[    0.033777] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes, linear)
[    0.038209] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes, linear)
[    0.045582] VFS: Finished mounting rootfs on nullfs
[    0.055494] rcu: Hierarchical SRCU implementation.
[    0.057831] rcu: 	Max phase no-delay instances is 1000.
[    0.062927] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level
[    0.068788] smp: Bringing up secondary CPUs ...
[    0.076880] Detected VIPT I-cache on CPU1
[    0.077054] CPU1: Booted secondary processor 0x0000000001 [0x410fd030]
[    0.077902] Detected VIPT I-cache on CPU2
[    0.078065] CPU2: Booted secondary processor 0x0000000002 [0x410fd030]
[    0.078879] Detected VIPT I-cache on CPU3
[    0.079033] CPU3: Booted secondary processor 0x0000000003 [0x410fd030]
[    0.079165] smp: Brought up 1 node, 4 CPUs
[    0.111995] SMP: Total of 4 processors activated.
[    0.116058] CPU: All CPU(s) started at EL1
[    0.120855] CPU features: detected: 32-bit EL0 Support
[    0.124818] CPU features: detected: CRC32 instructions
[    0.129961] CPU features: detected: PMUv3
[    0.135129] alternatives: applying system-wide alternatives
[    0.140365] Memory: 353700K/524288K available (11904K kernel code, 3340K rwdata, 5696K rodata, 1408K init, 463K bss, 135484K reserved, 32768K cma-reserved)
[    0.145304] devtmpfs: initialized
[    0.172888] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear)
[    0.173025] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear).
[    0.180041] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
[    0.187809] 0 pages in range for non-PLT usage
[    0.187817] 518528 pages in range for PLT usage
[    0.198640] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    0.204026] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
[    0.210380] thermal_sys: Registered thermal governor 'step_wise'
[    0.210391] thermal_sys: Registered thermal governor 'power_allocator'
[    0.216959] cpuidle: using governor menu
[    0.229383] NET: Registered PF_QIPCRTR protocol family
[    0.233445] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[    0.238330] ASID allocator initialised with 32768 entries
[    0.245596] Serial: AMBA PL011 UART driver
[    0.253227] CPUidle PSCI: Initialized CPU PM domain topology using OSI mode
[    0.262410] /soc@0/usb@78d9000: Fixed dependency cycle(s) with /soc@0/usb@78d9000/ulpi/phy
[    0.262518] /soc@0/usb@78d9000/ulpi/phy: Fixed dependency cycle(s) with /soc@0/usb@78d9000
[    0.269670] /soc@0/interrupt-controller@b000000: Fixed dependency cycle(s) with /soc@0/interrupt-controller@b000000
[    0.290664] /soc@0/usb@78d9000: Fixed dependency cycle(s) with /soc@0/usb@78d9000/ulpi/phy
[    0.290821] /soc@0/usb@78d9000/ulpi/phy: Fixed dependency cycle(s) with /soc@0/usb@78d9000
[    0.300447] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
[    0.306122] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
[    0.312968] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
[    0.319033] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
[    0.325978] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
[    0.332052] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
[    0.338999] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
[    0.345072] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
[    0.357361] iommu: Default domain type: Translated
[    0.358082] iommu: DMA domain TLB invalidation policy: strict mode
[    0.364036] pps_core: LinuxPPS API ver. 1 registered
[    0.369127] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    0.374261] PTP clock support registered
[    0.383448] EDAC MC: Ver: 3.0.0
[    0.387635] scmi_core: SCMI protocol bus registered
[    0.391339] qcom_scm: convention: smc arm 32
[    0.394987] qcom_scm firmware:scm: SHM Bridge not supported
[    0.399687] qcom_scm firmware:scm: qseecom: found qseecom with version 0x800000
[    0.404829] qcom_scm firmware:scm: qseecom: untested machine, skipping
[    0.412832] FPGA manager framework
[    0.420207] clocksource: Switched to clocksource arch_sys_counter
[    0.422385] VFS: Disk quotas dquot_6.6.0
[    0.428287] VFS: Dquot-cache hash table entries: 512 (4096 bytes)
[    0.441371] NET: Registered PF_INET protocol family
[    0.441523] IP idents hash table entries: 8192 (order: 4, 65536 bytes, linear)
[    0.445895] tcp_listen_portaddr_hash hash table entries: 256 (order: 0, 4096 bytes, linear)
[    0.452398] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[    0.460631] TCP established hash table entries: 4096 (order: 3, 32768 bytes, linear)
[    0.468653] TCP bind hash table entries: 4096 (order: 5, 131072 bytes, linear)
[    0.476472] TCP: Hash tables configured (established 4096 bind 4096)
[    0.483440] UDP hash table entries: 256 (order: 2, 16384 bytes, linear)
[    0.490007] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    0.496568] Unpacking initramfs...
[    0.503303] Initialise system trusted keyrings
[    0.505592] workingset: timestamp_bits=46 (anon: 41) max_order=17 bucket_order=0 (anon: 0)
[    0.510295] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[    0.518326] 9p: Installing v9fs 9p2000 file system support
[    0.524342] NET: Registered PF_ALG protocol family
[    0.529326] Key type asymmetric registered
[    0.534058] Asymmetric key parser 'x509' registered
[    0.538255] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 239)
[    0.542921] io scheduler mq-deadline registered
[    0.550565] io scheduler kyber registered
[    0.554883] io scheduler bfq registered
[    0.568118] ledtrig-cpu: registered to indicate activity on CPUs
[    0.568616] IPMI message handler: version 39.2
[    0.573340] ipmi device interface
[    0.577781] ipmi_si: IPMI System Interface driver
[    0.581115] ipmi_si: Unable to find any System Interface(s)
[    0.604431] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    0.608474] msm_serial 78b0000.serial: msm_serial: detected port #0
[    0.609596] msm_serial 78b0000.serial: uartclk = 7372800
[    0.616350] 78b0000.serial: ttyMSM0 at MMIO 0x78b0000 (irq = 17, base_baud = 460800) is a MSM
[    0.621406] msm_serial: console setup on port #0
[    0.621532] printk: legacy console [ttyMSM0] enabled
[    0.630135] printk: legacy bootconsole [msm_serial_dm0] disabled
[    0.645111] msm_serial: driver initialized
[    0.648531] qcom-iommu 1ef0000.iommu: iommu sec: pgtable size: 94208
[    0.668322] loop: module loaded
[    0.696126] spmi_pmic_arb 200f000.spmi: PMIC arbiter version v2 (0x20010000)
[    0.712842] tun: Universal TUN/TAP device driver, 1.6
[    0.713597] VFIO - User Level meta-driver version: 0.3
[    0.722001] rtc-pm8xxx 200f000.spmi:pmic@0:rtc@6000: registered as rtc0
[    0.722084] rtc-pm8xxx 200f000.spmi:pmic@0:rtc@6000: setting system clock to 1970-01-01T02:19:43 UTC (8383)
[    0.729082] i2c_dev: i2c /dev entries driver
[    0.742858] input: pm8941_pwrkey as /devices/platform/soc@0/200f000.spmi/spmi-0/0-00/200f000.spmi:pmic@0:pon@800/200f000.spmi:pmic@0:pon@800:pwrkey/input/input0
[    0.755348] qcom_rng 22000.rng: TRNG support not detected
[    0.757784] clocksource: arch_mmio_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
[    0.762331] arch-timer-mmio b020000.timer: mmio timer running at 19.20MHz (virt)
[    0.779407] hw perfevents: enabled with armv8_cortex_a53 PMU driver, 7 (0,8000003f) counters available
[    0.782254]  cs_system_cfg: CoreSight Configuration manager initialised
[    0.793137] gnss: GNSS driver registered with major 505
[    0.797957] NET: Registered PF_INET6 protocol family
[    0.803096] Segment Routing with IPv6
[    0.806743] In-situ OAM (IOAM) with IPv6
[    0.810306] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    0.814922] NET: Registered PF_PACKET protocol family
[    0.820295] 9pnet: Installing 9P2000 support
[    0.825170] Key type dns_resolver registered
[    0.839475] registered taskstats version 1
[    0.839526] Loading compiled-in X.509 certificates
[    0.875686] qcom-smsm smsm: mbox_request_channel: can't parse "mboxes" property
[    0.875744] qcom-smsm smsm: mbox_request_channel: can't parse "mboxes" property
[    0.881889] qcom-smsm smsm: mbox_request_channel: can't parse "mboxes" property
[    0.920713] msm_hsusb 78d9000.usb: Failed to create device link (0x180) with supplier remoteproc for /soc@0/usb@78d9000/ulpi/phy
[    0.924840] remoteproc remoteproc0: releasing 4080000.remoteproc
[    0.943098] s3: Bringing 0uV into 1250000-1250000uV
[    0.943846] s4: Bringing 0uV into 1850000-1850000uV
[    0.947792] l2: Bringing 0uV into 1200000-1200000uV
[    0.950218] remoteproc remoteproc0: releasing 4080000.remoteproc
[    0.952321] l5: Bringing 0uV into 1800000-1800000uV
[    0.963401] l6: Bringing 0uV into 1800000-1800000uV
[    0.966252] remoteproc remoteproc0: releasing 4080000.remoteproc
[    0.967672] l7: Bringing 0uV into 1800000-1800000uV
[    0.976350] remoteproc remoteproc0: releasing 4080000.remoteproc
[    0.979025] l8: Bringing 0uV into 2900000-2900000uV
[    0.983287] gcc-msm8916 1800000.clock-controller: sync_state() pending due to 4080000.remoteproc
[    0.989685] l9: Bringing 0uV into 3300000-3300000uV
[    0.993947] gcc-msm8916 1800000.clock-controller: sync_state() pending due to 7824900.mmc
[    1.003533] l11: Bringing 0uV into 2950000-2950000uV
[    1.007944] clk: Disabling unused clocks
[    1.016286] l12: Bringing 0uV into 1800000-1800000uV
[    1.021149] PM: genpd: Disabling unused power domains
[    1.025153] l13: Bringing 0uV into 3075000-3075000uV
[    1.042551] remoteproc remoteproc0: 4080000.remoteproc is available
[    1.075973] mmc0: SDHCI controller on 7824900.mmc [7824900.mmc] using ADMA
[    1.195998] mmc0: Card appears overclocked; req 177770000 Hz, actual 177777777 Hz
[    1.196059] mmc0: Card appears overclocked; req 177770000 Hz, actual 177777777 Hz
[    1.204817] mmc0: new HS200 MMC card at address 0001
[    1.210993] mmcblk0: mmc0:0001 H4G2a 3.64 GiB
[    1.222702]  mmcblk0: p1 p2 p3 p4 p5 p6 p7 p8 p9 p10 p11 p12 p13 p14 p15 p16 p17 p18 p19 p20 p21 p22 p23 p24 p25 p26 p27
[    1.224824] Freeing initrd memory: 11672K
[    1.228025] mmcblk0boot0: mmc0:0001 H4G2a 4.00 MiB
[    1.238018] Freeing unused kernel memory: 1408K
[    1.238195] Run /init as init process
[    1.241385]   with arguments:
[    1.243562] mmcblk0boot1: mmc0:0001 H4G2a 4.00 MiB
[    1.245190]     /init
[    1.245196]   with environment:
[    1.253229] mmcblk0rpmb: mmc0:0001 H4G2a 4.00 MiB, chardev (506:0)
[    1.255241]     HOME=/
[    1.264459]     TERM=linux
[    1.905028] [init] EMMC: all 30 block devices read-only (getro=1)
[    6.884736] [init] B1: modem FAT mounted RO at /firmware, firmware path /firmware/image
[    6.920697] configfs-gadget.aurora gadget.0: HOST MAC <MAC>
[    6.920739] configfs-gadget.aurora gadget.0: MAC <MAC>
[    6.926397] l13: voltage operation not allowed
[    6.933274] [init] usb gadget bound to UDC 'ci_hdrc.0'
[    6.949565] [init] ncm ifname='usb0' dev_addr=<MAC> host_addr=<MAC>
[    6.972419] [init] network: usb0 172.16.42.1/24 up (static, no DHCP)
[    9.549496] [aurora-modem] === START (conf /etc/aurora/modem.conf, apn 'internet.beeline.ru', ip-type ipv4)
[    9.623513] remoteproc remoteproc0: powering up 4080000.remoteproc
[    9.624034] remoteproc remoteproc0: Booting fw image mba.mbn, size 234176
[    9.637531] [aurora-modem] STATE OFF -> RMTFS_READY
[    9.643091] [aurora-modem] STATE RMTFS_READY -> MPSS_BOOTING
[    9.676472] qcom-q6v5-mss 4080000.remoteproc: MBA booted without debug policy, loading mpss
[   10.220171] remoteproc remoteproc0: remote processor 4080000.remoteproc is now up
[   10.317472] [aurora-modem] MSS running after 0.7s
[   10.323700] [aurora-modem] STATE MPSS_BOOTING -> MPSS_RUNNING
[   10.814863] wwan wwan0: port wwan0at0 attached
[   10.816365] wwan wwan0: port wwan0at1 attached
[   10.976316] wwan wwan0: port wwan0qmi0 attached
[   11.178797] [aurora-modem] wwan0qmi0 + wwan0 present after 0.8s; +2 s (JZ02 rpmsg_wwan_ctrl port-race guard, proven start_post)
[   13.368586] [aurora-modem] STATE MPSS_RUNNING -> QMI_READY
[   13.379915] [aurora-modem] DMS Mode: 'shutting-down' after 0.2s
[   13.431678] [aurora-modem] STATE QMI_READY -> SIM_READY
[   13.441833] [aurora-modem] UIM card present, USIM app ready after 0.0s
[   13.449278] [aurora-modem] SET: qmicli -p -d /dev/wwan0qmi0 --dms-set-operating-mode=online (retried only on DeviceNotReady, <= 30s)
[   16.697804] [aurora-modem] DMS online after 3.2s
[   16.703294] [aurora-modem] STATE SIM_READY -> RADIO_ONLINE
[   17.039474] [aurora-modem] REG t+0.3s: not-registered-searching / PS detached / none (none, ) - pci= si=/ cl=/
[   20.330449] [aurora-modem] REG t+3.6s: registered / PS attached / available (none, ps) 250-99 pci=390 si=7661/156416008 cl=7661/156416008
[   20.343556] [aurora-modem] registered: MCC: '250' MNC: '99' Description: 'Beeline' MCC: '250' MNC: '99' after 3.6s
[   20.350339] [aurora-modem] STATE RADIO_ONLINE -> REGISTERED
[   20.406032] udevd[1490]: starting version 3.2.14
[   20.410704] udevd[1490]: specified group 'tty' unknown
[   20.411129] udevd[1490]: specified group 'dialout' unknown
[   20.415095] udevd[1490]: specified group 'kmem' unknown
[   20.420555] udevd[1490]: specified group 'input' unknown
[   20.425492] udevd[1490]: specified group 'video' unknown
[   20.431125] udevd[1490]: specified group 'audio' unknown
[   20.436459] udevd[1490]: specified group 'lp' unknown
[   20.441653] udevd[1490]: specified group 'disk' unknown
[   20.446554] udevd[1490]: specified group 'cdrom' unknown
[   20.479841] udevd[1491]: starting eudev-3.2.14
[   20.847594] [aurora-modem] udevd started
[   20.877312] [aurora-modem] dbus started
[   20.891627] [aurora-modem] polkitd started
[   20.911945] [aurora-modem] ModemManager started pid 1535 (log mm-0.log)
[   61.085790] [aurora-modem] MM modem 0 detected after 40.2s
[   61.193741] [aurora-modem] STATE REGISTERED -> MM_READY
[   61.393984] [aurora-modem] MM state disabled after 0.2s
[   61.542428] [aurora-modem] mmcli -m 0 --simple-connect="apn=internet.beeline.ru,user=beeline,password=***,allowed-auth=pap,ip-type=ipv4"
[   72.185942] [aurora-modem] MM state connected, registration: home
[   72.269857] [aurora-modem] bearer 1: wwan0 10.80.93.64/25 gw 10.80.93.65 dns 10.10.22.1,194.186.191.1 mtu 1430
[   72.326539] [aurora-modem] STATE MM_READY -> BEARER_CONNECTED
[   72.338974] [aurora-modem] === START OK in 62.8s (wwan0 10.80.93.64/25, routes: 10.10.22.1 194.186.191.1 77.88.8.8 1.1.1.1 )
[  115.000766] [p6] date=1970-01-01T02:21:37 (clock not set by test)
[  115.025905] [p6] autostart: === service start rc=0 72.19 / START OK in 62.8s
[  120.372623] [aurora-modem] === DISCONNECT (from BEARER_CONNECTED: mss=running rmtfs=1043 mm=1535 bam=active)
[  120.998500] [aurora-modem] simple-disconnect rc=0 (bearers: 1 )
[  121.166493] [aurora-modem] no bearer connected
[  122.802144] [aurora-modem] BAM-DMUX suspended after 1.6s
[  122.809447] [aurora-modem] STATE BEARER_CONNECTED -> MM_IDLE
[  122.950578] [aurora-modem] === DISCONNECT done rc=0 in 2.5s (mss=running rmtfs='1043' mm='1535' mm_state=registered bam=suspended)
[  128.063565] [aurora-modem] === START (conf /etc/aurora/modem.conf, apn 'internet.beeline.ru', ip-type ipv4)
[  128.123292] [aurora-modem] rmtfs 1043 + MSS running already - reuse
[  128.129231] [aurora-modem] STATE MM_IDLE -> MPSS_RUNNING
[  128.142728] [aurora-modem] wwan0qmi0 + wwan0 present after 0.0s; +2 s (JZ02 rpmsg_wwan_ctrl port-race guard, proven start_post)
[  130.169149] [aurora-modem] ModemManager already running - skip qmicli, use MM state
[  130.175063] [aurora-modem] STATE MPSS_RUNNING -> QMI_READY
[  130.336977] [aurora-modem] MM modem 0 detected after 0.1s
[  130.438880] [aurora-modem] STATE QMI_READY -> MM_READY
[  130.632286] [aurora-modem] MM state registered after 0.2s
[  130.825240] [aurora-modem] mmcli -m 0 --simple-connect="apn=internet.beeline.ru,user=beeline,password=***,allowed-auth=pap,ip-type=ipv4"
[  134.068441] [aurora-modem] MM state connected, registration: home
[  134.149644] [aurora-modem] bearer 1: wwan0 10.80.93.64/25 gw 10.80.93.65 dns 10.10.22.1,194.186.191.1 mtu 1430
[  134.207341] [aurora-modem] STATE MM_READY -> BEARER_CONNECTED
[  134.217865] [aurora-modem] === START OK in 6.2s (wwan0 10.80.93.64/25, routes: 10.10.22.1 194.186.191.1 77.88.8.8 1.1.1.1 )
[  138.755440] [p6] cycle 1: 1 reconnect+data 0 10.80.93.64 DATATEST PASS dns=1(ya=5.255.255.242 go=142.251.150.119) ping=3+3 http=code=302 https=[](skip) if=wwan0 addr=10.80.93.64 9 wwan0, active running 1043 1535 ok 0/0 0
[  138.815559] [aurora-modem] === DISCONNECT (from BEARER_CONNECTED: mss=running rmtfs=1043 mm=1535 bam=active)
[  139.453441] [aurora-modem] simple-disconnect rc=0 (bearers: 1 )
[  139.632048] [aurora-modem] no bearer connected
[  141.247533] [aurora-modem] BAM-DMUX suspended after 1.6s
[  141.253482] [aurora-modem] STATE BEARER_CONNECTED -> MM_IDLE
[  141.395818] [aurora-modem] === DISCONNECT done rc=0 in 2.5s (mss=running rmtfs='1043' mm='1535' mm_state=registered bam=suspended)
[  146.501083] [aurora-modem] === START (conf /etc/aurora/modem.conf, apn 'internet.beeline.ru', ip-type ipv4)
[  146.560323] [aurora-modem] rmtfs 1043 + MSS running already - reuse
[  146.567989] [aurora-modem] STATE MM_IDLE -> MPSS_RUNNING
[  146.582422] [aurora-modem] wwan0qmi0 + wwan0 present after 0.0s; +2 s (JZ02 rpmsg_wwan_ctrl port-race guard, proven start_post)
[  148.609052] [aurora-modem] ModemManager already running - skip qmicli, use MM state
[  148.614901] [aurora-modem] STATE MPSS_RUNNING -> QMI_READY
[  148.777470] [aurora-modem] MM modem 0 detected after 0.1s
[  148.891797] [aurora-modem] STATE QMI_READY -> MM_READY
[  149.094630] [aurora-modem] MM state registered after 0.2s
[  149.284544] [aurora-modem] mmcli -m 0 --simple-connect="apn=internet.beeline.ru,user=beeline,password=***,allowed-auth=pap,ip-type=ipv4"
[  152.565211] [aurora-modem] MM state connected, registration: home
[  152.685842] [aurora-modem] bearer 1: wwan0 10.80.93.64/25 gw 10.80.93.65 dns 10.10.22.1,194.186.191.1 mtu 1430
[  152.758765] [aurora-modem] STATE MM_READY -> BEARER_CONNECTED
[  152.781034] [aurora-modem] === START OK in 6.3s (wwan0 10.80.93.64/25, routes: 10.10.22.1 194.186.191.1 77.88.8.8 1.1.1.1 )
[  157.529903] [p6] cycle 2: 2 reconnect+data 0 10.80.93.64 DATATEST PASS dns=1(ya=5.255.255.242 go=142.251.150.119) ping=3+3 http=code=302 https=[](skip) if=wwan0 addr=10.80.93.64 9 wwan0, active running 1043 1535 ok 0/0 0
[  157.592349] [aurora-modem] === DISCONNECT (from BEARER_CONNECTED: mss=running rmtfs=1043 mm=1535 bam=active)
[  158.246056] [aurora-modem] simple-disconnect rc=0 (bearers: 1 )
[  158.434592] [aurora-modem] no bearer connected
[  159.539393] [aurora-modem] BAM-DMUX suspended after 1.0s
[  159.545423] [aurora-modem] STATE BEARER_CONNECTED -> MM_IDLE
[  159.685369] [aurora-modem] === DISCONNECT done rc=0 in 2.0s (mss=running rmtfs='1043' mm='1535' mm_state=registered bam=suspended)
[  164.793094] [aurora-modem] === START (conf /etc/aurora/modem.conf, apn 'internet.beeline.ru', ip-type ipv4)
[  164.855691] [aurora-modem] rmtfs 1043 + MSS running already - reuse
[  164.861721] [aurora-modem] STATE MM_IDLE -> MPSS_RUNNING
[  164.875001] [aurora-modem] wwan0qmi0 + wwan0 present after 0.0s; +2 s (JZ02 rpmsg_wwan_ctrl port-race guard, proven start_post)
[  166.901670] [aurora-modem] ModemManager already running - skip qmicli, use MM state
[  166.907722] [aurora-modem] STATE MPSS_RUNNING -> QMI_READY
[  167.068898] [aurora-modem] MM modem 0 detected after 0.1s
[  167.172744] [aurora-modem] STATE QMI_READY -> MM_READY
[  167.368861] [aurora-modem] MM state registered after 0.2s
[  167.562257] [aurora-modem] mmcli -m 0 --simple-connect="apn=internet.beeline.ru,user=beeline,password=***,allowed-auth=pap,ip-type=ipv4"
[  171.147381] [aurora-modem] MM state connected, registration: home
[  171.228113] [aurora-modem] bearer 1: wwan0 10.80.93.64/25 gw 10.80.93.65 dns 10.10.22.1,194.186.191.1 mtu 1430
[  171.284878] [aurora-modem] STATE MM_READY -> BEARER_CONNECTED
[  171.296510] [aurora-modem] === START OK in 6.5s (wwan0 10.80.93.64/25, routes: 10.10.22.1 194.186.191.1 77.88.8.8 1.1.1.1 )
[  176.073529] [p6] cycle 3: 3 reconnect+data 0 10.80.93.64 DATATEST PASS dns=1(ya=5.255.255.242 go=142.251.150.119) ping=3+3 http=code=302 https=[](skip) if=wwan0 addr=10.80.93.64 9 wwan0, active running 1043 1535 ok 0/0 0
[  176.079884] [p6] RESULT before stop: all PASS
[  176.681693] [aurora-modem] === STOP (from BEARER_CONNECTED: mss=running rmtfs=1043 mm=1535 bam=active)
[  177.310224] [aurora-modem] simple-disconnect rc=0 (bearers: 1 )
[  177.487546] [aurora-modem] no bearer connected
[  177.561663] [aurora-modem] wwan links down, addresses/routes removed
[  177.569727] [aurora-modem] STATE BEARER_CONNECTED -> WWAN_DOWN
[  180.260929] [aurora-modem] ModemManager stopped
[  180.300527] [aurora-modem] qmi-proxy stopped
[  180.306085] [aurora-modem] STATE WWAN_DOWN -> MM_STOPPED
[  180.333622] [aurora-modem] BAM-DMUX suspended after 0.0s
[  180.352045] wwan wwan0: port wwan0at0 disconnected
[  180.352574] wwan wwan0: port wwan0at1 disconnected
[  180.352654] [aurora-modem] SIGTERM rmtfs 1043 (rmtfs stops MSS, then exits)
[  180.356526] wwan wwan0: port wwan0qmi0 disconnected
[  180.374241] remoteproc remoteproc0: stopped remote processor 4080000.remoteproc
[  180.597935] [aurora-modem] MSS offline after 0.2s (rmtfs alive: no)
[  180.604984] [aurora-modem] STATE MM_STOPPED -> MPSS_STOPPED
[  180.620253] [aurora-modem] rmtfs exited after 0.3s
[  180.634479] [aurora-modem] STATE MPSS_STOPPED -> OFF
[  180.682987] [aurora-modem] === STOP done rc=0 in 4.0s (mss=offline rmtfs='' mm='' bam=suspended)
