Important: Please read the Qt Code of Conduct - https://forum.qt.io/topic/113070/qt-code-of-conduct

Network error with QNetworkReplyHttpImpl



  • Hi,
    I've random network error when using QNetworkAccessManager with Qt 5.11 on a embedded system built with Yocto (Linux kernel). Sometimes I get this error:

    [25.07.2019 16:01:25] {WARNING} QIODevice::read (QNetworkReplyHttpImpl): device not open
    [25.07.2019 16:01:25] {CRITICAL} QNetworkReply::NetworkError(OperationCanceledError) : Operation canceled
    

    What does it mean? Why does it occur? How to fix this issue?
    Thank you


  • Moderators

    Perhaps OS is blocking the network device? Or you're running out of RAM?

    I have no idea for a fix, just throwing some ideas, maybe it will help.



  • Thanks for your answer, I have 1GB of RAM and when I run free -m I get this output:

                  total        used        free      shared  buff/cache   available
    Mem:           1006         265         596          12         145         716
    Swap:             0           0           0
    

    How do I know if the OS is blocking the device?


  • Qt Champions 2019

    @cyrilfr Do you see anything related to network in the output of "dmesg" or in /var/log/syslog ?



  • @jsulm said in Network error with QNetworkReplyHttpImpl:

    /var/log/syslog

    I don't see anything problematic:

    Jul 26 09:28:42 syslogd 1.5.1: restart.
    Jul 26 09:28:42 bluetoothd[449]: Bluetooth management interface 1.9 initialized
    Jul 26 09:28:42 kernel: klogd 1.5.1, log source = /proc/kmsg started.
    Jul 26 09:28:42 kernel: Cannot find map file.
    Jul 26 09:28:42 kernel: Loaded 70816 symbols from 36 modules.
    Jul 26 09:28:42 kernel: [    0.000000] Booting Linux on physical CPU 0x0
    Jul 26 09:28:42 kernel: [    0.000000] Linux version 4.1.15+2.0.x-udoo+gf9dad51d6e51 (oe-user@oe-host) (gcc version 8.2.0 (GCC) ) #1 SMP PREEMPT Thu Apr 11 16:25:05 UTC 2019
    Jul 26 09:28:42 kernel: [    0.000000] CPU: ARMv7 Processor [412fc09a] revision 10 (ARMv7), cr=10c53c7d
    Jul 26 09:28:42 kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
    Jul 26 09:28:42 kernel: [    0.000000] Machine model: UDOO Neo Extended
    Jul 26 09:28:42 kernel: [    0.000000] Reserved memory: created CMA memory pool at 0xac000000, size 320 MiB
    Jul 26 09:28:42 kernel: [    0.000000] Reserved memory: initialized node linux,cma, compatible id shared-dma-pool
    Jul 26 09:28:42 kernel: [    0.000000] Memory policy: Data cache writealloc
    Jul 26 09:28:42 kernel: [    0.000000] On node 0 totalpages: 262144
    Jul 26 09:28:42 kernel: [    0.000000] free_area_init_node: node 0, pgdat 8075c6c0, node_mem_map ab757000
    Jul 26 09:28:42 kernel: [    0.000000]   Normal zone: 2048 pages used for memmap
    Jul 26 09:28:42 kernel: [    0.000000]   Normal zone: 0 pages reserved
    Jul 26 09:28:42 kernel: [    0.000000]   Normal zone: 262144 pages, LIFO batch:31
    Jul 26 09:28:42 kernel: [    0.000000] PERCPU: Embedded 12 pages/cpu @ab727000 s16908 r8192 d24052 u49152
    Jul 26 09:28:42 kernel: [    0.000000] pcpu-alloc: s16908 r8192 d24052 u49152 alloc=12*4096
    Jul 26 09:28:42 kernel: [    0.000000] pcpu-alloc: [0] 0 
    Jul 26 09:28:42 kernel: [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 260096
    Jul 26 09:28:42 kernel: [    0.000000] Kernel command line: console=ttymxc0,115200,115200 root=/dev/mmcblk0p1 rootwait rw rootfstype=ext4 uart_from_osc clk_ignore_unused cpuidle.off=1 consoleblank=0
    Jul 26 09:28:42 kernel: [    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
    Jul 26 09:28:42 kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
    Jul 26 09:28:42 kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
    Jul 26 09:28:42 kernel: [    0.000000] Memory: 703104K/1048576K available (5132K kernel code, 237K rwdata, 1872K rodata, 264K init, 379K bss, 17792K reserved, 327680K cma-reserved, 0K highmem)
    Jul 26 09:28:42 kernel: [    0.000000] Virtual kernel memory layout:
    Jul 26 09:28:42 kernel: [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
    Jul 26 09:28:42 kernel: [    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
    Jul 26 09:28:42 kernel: [    0.000000]     vmalloc : 0xc0800000 - 0xff000000   (1000 MB)
    Jul 26 09:28:42 kernel: [    0.000000]     lowmem  : 0x80000000 - 0xc0000000   (1024 MB)
    Jul 26 09:28:42 kernel: [    0.000000]     pkmap   : 0x7fe00000 - 0x80000000   (   2 MB)
    Jul 26 09:28:42 kernel: [    0.000000]     modules : 0x7f000000 - 0x7fe00000   (  14 MB)
    Jul 26 09:28:42 kernel: [    0.000000]       .text : 0x80008000 - 0x806df454   (7006 kB)
    Jul 26 09:28:42 kernel: [    0.000000]       .init : 0x806e0000 - 0x80722000   ( 264 kB)
    Jul 26 09:28:42 kernel: [    0.000000]       .data : 0x80722000 - 0x8075d740   ( 238 kB)
    Jul 26 09:28:42 kernel: [    0.000000]        .bss : 0x8075d740 - 0x807bc424   ( 380 kB)
    Jul 26 09:28:42 kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
    Jul 26 09:28:42 kernel: [    0.000000] Preemptible hierarchical RCU implementation.
    Jul 26 09:28:42 kernel: [    0.000000] ^IRCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=1.
    Jul 26 09:28:42 kernel: [    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
    Jul 26 09:28:42 kernel: [    0.000000] NR_IRQS:16 nr_irqs:16 16
    Jul 26 09:28:42 kernel: [    0.000000] L2C-310 erratum 769419 enabled
    Jul 26 09:28:42 kernel: [    0.000000] L2C-310 enabling early BRESP for Cortex-A9
    Jul 26 09:28:42 kernel: [    0.000000] L2C-310 full line of zeros enabled for Cortex-A9
    Jul 26 09:28:42 kernel: [    0.000000] L2C-310 ID prefetch enabled, offset 16 lines
    Jul 26 09:28:42 kernel: [    0.000000] L2C-310 dynamic clock gating enabled, standby mode enabled
    Jul 26 09:28:42 kernel: [    0.000000] L2C-310 cache controller enabled, 16 ways, 256 kB
    Jul 26 09:28:42 kernel: [    0.000000] L2C-310: CACHE_ID 0x410000c8, AUX_CTRL 0x76430001
    Jul 26 09:28:42 kernel: [    0.000000] mxc_clocksource_init 3000000
    Jul 26 09:28:42 kernel: [    0.000000] Switching to timer-based delay loop, resolution 333ns
    Jul 26 09:28:42 kernel: [    0.000007] sched_clock: 32 bits at 3000kHz, resolution 333ns, wraps every 715827882841ns
    Jul 26 09:28:42 kernel: [    0.000025] clocksource mxc_timer1: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 637086815595 ns
    Jul 26 09:28:42 kernel: [    0.001376] Console: colour dummy device 80x30
    Jul 26 09:28:42 kernel: [    0.001394] Calibrating delay loop (skipped), value calculated using timer frequency.. 6.00 BogoMIPS (lpj=30000)
    Jul 26 09:28:42 kernel: [    0.001409] pid_max: default: 32768 minimum: 301
    Jul 26 09:28:42 kernel: [    0.001491] Security Framework initialized
    Jul 26 09:28:42 kernel: [    0.001531] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
    Jul 26 09:28:42 kernel: [    0.001543] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
    Jul 26 09:28:42 kernel: [    0.002120] Initializing cgroup subsys devices
    Jul 26 09:28:42 kernel: [    0.002143] Initializing cgroup subsys freezer
    Jul 26 09:28:42 kernel: [    0.002170] CPU: Testing write buffer coherency: ok
    Jul 26 09:28:42 kernel: [    0.002413] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
    Jul 26 09:28:42 kernel: [    0.002478] Setting up static identity map for 0x80008280 - 0x800082d8
    Jul 26 09:28:42 kernel: [    0.040635] Brought up 1 CPUs
    Jul 26 09:28:42 kernel: [    0.040652] SMP: Total of 1 processors activated (6.00 BogoMIPS).
    Jul 26 09:28:42 kernel: [    0.040660] CPU: All CPU(s) started in SVC mode.
    Jul 26 09:28:42 kernel: [    0.041175] devtmpfs: initialized
    Jul 26 09:28:42 kernel: [    0.049232] device-tree: Duplicate name in lcdif@02224000, renamed to "display#1"
    Jul 26 09:28:42 kernel: [    0.052428] VFP support v0.3: implementor 41 architecture 3 part 30 variant 9 rev 4
    Jul 26 09:28:42 kernel: [    0.052779] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
    Jul 26 09:28:42 kernel: [    0.068723] pinctrl core: initialized pinctrl subsystem
    Jul 26 09:28:42 kernel: [    0.069818] NET: Registered protocol family 16
    Jul 26 09:28:42 kernel: [    0.078258] DMA: preallocated 256 KiB pool for atomic coherent allocations
    Jul 26 09:28:42 kernel: [    0.102270] hw-breakpoint: found 5 (+1 reserved) breakpoint and 1 watchpoint registers.
    Jul 26 09:28:42 kernel: [    0.102284] hw-breakpoint: maximum watchpoint size is 4 bytes.
    Jul 26 09:28:42 kernel: [    0.103488] imx6sx-pinctrl 20e0000.iomuxc: initialized IMX pinctrl driver
    Jul 26 09:28:42 kernel: [    0.105165] MU is ready for cross core communication!
    Jul 26 09:28:42 kernel: [    0.111683] mxs-dma 1804000.dma-apbh: initialized
    Jul 26 09:28:42 kernel: [    0.115252] SCSI subsystem initialized
    Jul 26 09:28:42 kernel: [    0.115555] usbcore: registered new interface driver usbfs
    Jul 26 09:28:42 kernel: [    0.115622] usbcore: registered new interface driver hub
    Jul 26 09:28:42 kernel: [    0.115760] usbcore: registered new device driver usb
    Jul 26 09:28:42 kernel: [    0.115966] 2000000.aips-bus:usbphy_nop1 supply vcc not found, using dummy regulator
    Jul 26 09:28:42 kernel: [    0.117084] i2c i2c-0: IMX I2C adapter registered
    Jul 26 09:28:42 kernel: [    0.117104] i2c i2c-0: can't use DMA
    Jul 26 09:28:42 kernel: [    0.117906] i2c i2c-1: IMX I2C adapter registered
    Jul 26 09:28:42 kernel: [    0.117925] i2c i2c-1: can't use DMA
    Jul 26 09:28:42 kernel: [    0.118635] i2c i2c-3: IMX I2C adapter registered
    Jul 26 09:28:42 kernel: [    0.118653] i2c i2c-3: can't use DMA
    Jul 26 09:28:42 kernel: [    0.118803] pps_core: LinuxPPS API ver. 1 registered
    Jul 26 09:28:42 kernel: [    0.118813] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
    Jul 26 09:28:42 kernel: [    0.118844] PTP clock support registered
    Jul 26 09:28:42 kernel: [    0.119744] Advanced Linux Sound Architecture Driver Initialized.
    Jul 26 09:28:42 kernel: [    0.120980] Switched to clocksource mxc_timer1
    Jul 26 09:28:42 kernel: [    0.131708] NET: Registered protocol family 2
    Jul 26 09:28:42 kernel: [    0.132440] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
    Jul 26 09:28:42 kernel: [    0.132528] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
    Jul 26 09:28:42 kernel: [    0.132657] TCP: Hash tables configured (established 8192 bind 8192)
    Jul 26 09:28:42 kernel: [    0.132739] UDP hash table entries: 512 (order: 2, 16384 bytes)
    Jul 26 09:28:42 kernel: [    0.132778] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
    Jul 26 09:28:42 kernel: [    0.132978] NET: Registered protocol family 1
    Jul 26 09:28:42 kernel: [    0.133358] CPU PMU: Failed to parse /soc/pmu/interrupt-affinity[0]
    Jul 26 09:28:42 kernel: [    0.133402] hw perfevents: enabled with armv7_cortex_a9 PMU driver, 7 counters available
    Jul 26 09:28:42 kernel: [    0.134514] imx rpmsg driver is registered.
    Jul 26 09:28:42 kernel: [    0.135510] Bus freq driver module loaded
    Jul 26 09:28:42 kernel: [    0.136387] futex hash table entries: 256 (order: 2, 16384 bytes)
    Jul 26 09:28:42 kernel: [    0.143195] VFS: Disk quotas dquot_6.6.0
    Jul 26 09:28:42 kernel: [    0.143388] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
    Jul 26 09:28:42 kernel: [    0.149177] io scheduler noop registered
    Jul 26 09:28:42 kernel: [    0.149197] io scheduler deadline registered
    Jul 26 09:28:42 kernel: [    0.149254] io scheduler cfq registered (default)
    Jul 26 09:28:42 kernel: [    0.149752] imx-weim 21b8000.weim: Driver registered.
    Jul 26 09:28:42 kernel: [    0.151571] MIPI DSI driver module loaded
    Jul 26 09:28:42 kernel: [    0.154224] 2224000.lcdif supply lcd not found, using dummy regulator
    Jul 26 09:28:42 kernel: [    0.259246] mxsfb 2224000.lcdif: registered mxc display driver ldb
    Jul 26 09:28:42 kernel: [    0.259631] mxsfb 2224000.lcdif: initialized
    Jul 26 09:28:42 kernel: [    0.262729] imx-sdma 20ec000.sdma: no iram assigned, using external mem
    Jul 26 09:28:42 kernel: [    0.264530] imx-sdma 20ec000.sdma: no event needs to be remapped
    Jul 26 09:28:42 kernel: [    0.265507] imx-sdma 20ec000.sdma: loaded firmware 3.3
    Jul 26 09:28:42 kernel: [    0.268380] imx-sdma 20ec000.sdma: initialized
    Jul 26 09:28:42 kernel: [    0.270130] pfuze100-regulator 0-0008: Full layer: 1, Metal layer: 1
    Jul 26 09:28:42 kernel: [    0.270728] pfuze100-regulator 0-0008: FAB: 0, FIN: 0
    Jul 26 09:28:42 kernel: [    0.270742] pfuze100-regulator 0-0008: pfuze3000 found.
    Jul 26 09:28:42 kernel: [    0.285688] 2020000.serial: ttymxc0 at MMIO 0x2020000 (irq = 23, base_baud = 1500000) is a IMX
    Jul 26 09:28:42 kernel: [    0.962963] console [ttymxc0] enabled
    Jul 26 09:28:42 kernel: [    0.967499] 21ec000.serial: ttymxc2 at MMIO 0x21ec000 (irq = 284, base_baud = 1500000) is a IMX
    Jul 26 09:28:42 kernel: [    0.978690] imx sema4 driver is registered.
    Jul 26 09:28:42 kernel: [    0.983042] [drm] Initialized drm 1.1.0 20060810
    Jul 26 09:28:42 kernel: [    0.988209] [drm] Initialized vivante 1.0.0 20120216 on minor 0
    Jul 26 09:28:42 kernel: [    0.999576] loop: module loaded
    Jul 26 09:28:42 kernel: [    1.005507] spi_imx 200c000.ecspi: probed
    Jul 26 09:28:42 kernel: [    1.010590] usbcore: registered new interface driver cdc_wdm
    Jul 26 09:28:42 kernel: [    1.016520] usbcore: registered new interface driver usbserial
    Jul 26 09:28:42 kernel: [    1.022451] usbcore: registered new interface driver usbserial_generic
    Jul 26 09:28:42 kernel: [    1.029025] usbserial: USB Serial support registered for generic
    Jul 26 09:28:42 kernel: [    1.035621] input: 20cc000.snvs:snvs-powerkey as /devices/soc0/soc/2000000.aips-bus/20cc000.snvs/20cc000.snvs:snvs-powerkey/input/input0
    Jul 26 09:28:42 kernel: [    1.049031] input: st1232-touchscreen as /devices/soc0/soc/2100000.aips-bus/21a0000.i2c/i2c-0/0-0055/input/input1
    Jul 26 09:28:42 kernel: [    1.060761] snvs_rtc 20cc000.snvs:snvs-rtc-lp: rtc core: registered 20cc000.snvs:snvs-r as rtc0
    Jul 26 09:28:42 kernel: [    1.069708] i2c /dev entries driver
    Jul 26 09:28:42 kernel: [    1.075085] imx2-wdt 20bc000.wdog: timeout 60 sec (nowayout=0)
    Jul 26 09:28:42 kernel: [    1.081361] sdhci: Secure Digital Host Controller Interface driver
    Jul 26 09:28:42 kernel: [    1.087553] sdhci: Copyright(c) Pierre Ossman
    Jul 26 09:28:42 kernel: [    1.091962] sdhci-pltfm: SDHCI platform and OF driver helper
    Jul 26 09:28:42 kernel: [    1.098837] /soc/aips-bus@02100000/usdhc@02194000: voltage-ranges unspecified
    Jul 26 09:28:42 kernel: [    1.106057] sdhci-esdhc-imx 2194000.usdhc: Got CD GPIO
    Jul 26 09:28:42 kernel: [    1.112353] sdhci-esdhc-imx 2194000.usdhc: No vqmmc regulator found
    Jul 26 09:28:42 kernel: [    1.161243] mmc0: SDHCI controller on 2194000.usdhc [2194000.usdhc] using ADMA
    Jul 26 09:28:42 kernel: [    1.172193] /soc/aips-bus@02100000/usdhc@02198000: voltage-ranges unspecified
    Jul 26 09:28:42 kernel: [    1.184470] sdhci-esdhc-imx 2198000.usdhc: could not get ultra high speed state, work on normal mode
    Jul 26 09:28:42 kernel: [    1.198847] sdhci-esdhc-imx 2198000.usdhc: No vqmmc regulator found
    Jul 26 09:28:42 kernel: [    1.252702] mmc0: host does not support reading read-only switch, assuming write-enable
    Jul 26 09:28:42 kernel: [    1.270596] mmc0: new high speed SDHC card at address aaaa
    Jul 26 09:28:42 kernel: [    1.276547] mmcblk0: mmc0:aaaa SC16G 14.8 GiB 
    Jul 26 09:28:42 kernel: [    1.286300]  mmcblk0: p1
    Jul 26 09:28:42 kernel: [    1.321004] mmc2: SDHCI controller on 2198000.usdhc [2198000.usdhc] using ADMA
    Jul 26 09:28:42 kernel: [    1.339546] caam 2100000.caam: Entropy delay = 3200
    Jul 26 09:28:42 kernel: [    1.350275] sdhci-esdhc-imx 2198000.usdhc: card claims to support voltages below defined range
    Jul 26 09:28:42 kernel: [    1.393298] mmc2: queuing unknown CIS tuple 0x91 (3 bytes)
    Jul 26 09:28:42 kernel: [    1.412171] mmc2: new high speed SDIO card at address 0001
    Jul 26 09:28:42 kernel: [    1.469092] caam 2100000.caam: Entropy delay = 3600
    Jul 26 09:28:42 kernel: [    1.610694] caam 2100000.caam: Entropy delay = 4000
    Jul 26 09:28:42 kernel: [    1.767444] caam 2100000.caam: Instantiated RNG4 SH0
    Jul 26 09:28:42 kernel: [    1.843358] caam 2100000.caam: Instantiated RNG4 SH1
    Jul 26 09:28:42 kernel: [    1.848337] caam 2100000.caam: device ID = 0x0a16010000000200 (Era -524)
    Jul 26 09:28:42 kernel: [    1.855061] caam 2100000.caam: job rings = 2, qi = 0
    Jul 26 09:28:42 kernel: [    1.927434] caam algorithms registered in /proc/crypto
    Jul 26 09:28:42 kernel: [    1.936831] caam_jr 2101000.jr0: registering rng-caam
    Jul 26 09:28:42 kernel: [    1.942801] snvs-secvio 20cc000.caam-snvs: can't get snvs clock
    Jul 26 09:28:42 kernel: [    1.948789] snvs-secvio 20cc000.caam-snvs: violation handlers armed - non-secure state
    Jul 26 09:28:42 kernel: [    1.962261] fsl-asrc 2034000.asrc: driver registered
    Jul 26 09:28:42 kernel: [    1.969738] nf_conntrack version 0.5.0 (16106 buckets, 64424 max)
    Jul 26 09:28:42 kernel: [    1.976588] NET: Registered protocol family 17
    Jul 26 09:28:42 kernel: [    1.981246] NET: Registered protocol family 36
    Jul 26 09:28:42 kernel: [    1.985737] Key type dns_resolver registered
    Jul 26 09:28:42 kernel: [    1.990656] cpu cpu0: dev_pm_opp_get_opp_count: device OPP not found (-19)
    Jul 26 09:28:42 kernel: [    2.011022] failed to register cpuidle driver
    Jul 26 09:28:42 kernel: [    2.015413] ThumbEE CPU extension supported.
    Jul 26 09:28:42 kernel: [    2.022798] snvs_rtc 20cc000.snvs:snvs-rtc-lp: setting system clock to 2019-07-26 07:28:26 UTC (1564126106)
    Jul 26 09:28:42 kernel: [    2.042366] VLDO2: disabling
    Jul 26 09:28:42 kernel: [    2.045754] wlan-en-regulator: disabling
    Jul 26 09:28:42 kernel: [    2.049687] PSU-5V0: disabling
    Jul 26 09:28:42 kernel: [    2.052792] usb_otg2_vbus: disabling
    Jul 26 09:28:42 kernel: [    2.056373] usb_otg1_vbus: disabling
    Jul 26 09:28:42 kernel: [    2.059958] vddpcie-phy: disabling
    Jul 26 09:28:42 kernel: [    2.063411] clk: Not disabling unused clocks
    Jul 26 09:28:42 kernel: [    2.067696] ALSA device list:
    Jul 26 09:28:42 kernel: [    2.070665]   No soundcards found.
    Jul 26 09:28:42 kernel: [    2.127809] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null)
    Jul 26 09:28:42 kernel: [    2.136018] VFS: Mounted root (ext4 filesystem) on device 179:1.
    Jul 26 09:28:42 kernel: [    2.145400] devtmpfs: mounted
    Jul 26 09:28:42 kernel: [    2.148579] Freeing unused kernel memory: 264K (806e0000 - 80722000)
    Jul 26 09:28:42 kernel: <30>[    2.906598] udevd[160]: starting version 3.2.7
    Jul 26 09:28:42 kernel: [    2.939491] random: udevd urandom read with 17 bits of entropy available
    Jul 26 09:28:42 kernel: <27>[    2.958532] udevd[160]: specified group 'kvm' unknown
    Jul 26 09:28:42 kernel: <30>[    2.992975] udevd[161]: starting eudev-3.2.7
    Jul 26 09:28:42 kernel: <27>[    3.053428] udevd[161]: specified group 'kvm' unknown
    Jul 26 09:28:42 kernel: [    3.136545] (stk) :sysfs entries created
    Jul 26 09:28:42 kernel: [    3.186321] Bluetooth: Core ver 2.20
    Jul 26 09:28:42 kernel: [    3.216547] mrf24j40 spi1.0: probe(). IRQ: 44
    Jul 26 09:28:42 kernel: [    3.223387] NET: Registered protocol family 31
    Jul 26 09:28:42 kernel: [    3.227842] Bluetooth: HCI device and connection manager initialized
    Jul 26 09:28:42 kernel: [    3.235171] galcore: clk_get 2d core clock failed, disable 2d/vg!
    Jul 26 09:28:42 kernel: [    3.265999] Galcore version 6.2.4.150331
    Jul 26 09:28:42 kernel: [    3.273126] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
    Jul 26 09:28:42 kernel: [    3.304876] Bluetooth: HCI socket layer initialized
    Jul 26 09:28:42 kernel: [    3.314030] 2184800.usbmisc supply vbus-wakeup not found, using dummy regulator
    Jul 26 09:28:42 kernel: [    3.346461] Bluetooth: L2CAP socket layer initialized
    Jul 26 09:28:42 kernel: [    3.371216] Bluetooth: SCO socket layer initialized
    Jul 26 09:28:42 kernel: [    3.403609] ci_hdrc ci_hdrc.1: EHCI Host Controller
    Jul 26 09:28:42 kernel: [    3.410822] hdev a82aa000
    Jul 26 09:28:42 kernel: [    3.418230] HCI device registered (hdev a82aa000)
    Jul 26 09:28:42 kernel: [    3.418790] hci0 a82aa000
    Jul 26 09:28:42 kernel: [    3.418803] (stc):  chnl_id list empty :4 
    Jul 26 09:28:42 kernel: [    3.422817] (stk) : st_kim_start(stk) :ldisc_install = 1
    Jul 26 09:28:42 kernel: [    3.537046] ci_hdrc ci_hdrc.1: new USB bus registered, assigned bus number 1
    Jul 26 09:28:42 kernel: [    3.591166] ci_hdrc ci_hdrc.1: USB 2.0 started, EHCI 1.00
    Jul 26 09:28:42 kernel: [    3.616317] hub 1-0:1.0: USB hub found
    Jul 26 09:28:42 kernel: [    3.631171] hub 1-0:1.0: 1 port detected
    Jul 26 09:28:42 kernel: [    3.723695] input: FreescaleGyroscope as /devices/virtual/input/input2
    Jul 26 09:28:42 kernel: [    3.737984] Loading modules backported from Linux version R8.7_SP3-0-g8cbba968049b
    Jul 26 09:28:42 kernel: [    3.772617] fxas2100x device driver probe successfully
    Jul 26 09:28:42 kernel: [    3.782588] Backport generated by backports.git R8.7_SP3-0-gd4777ef8
    Jul 26 09:28:42 kernel: [    3.807217] input: FreescaleAccelerometer as /devices/virtual/input/input3
    Jul 26 09:28:42 kernel: [    3.841618] input: FreescaleMagnetometer as /devices/virtual/input/input4
    Jul 26 09:28:42 kernel: [    3.885185] fxos8700 device driver probe successfully
    Jul 26 09:28:42 kernel: [    4.305895] wl18xx_driver wl18xx.0.auto: Direct firmware load for ti-connectivity/wl1271-nvs.bin failed with error -2
    Jul 26 09:28:42 kernel: [    4.422209] g_serial gadget: Gadget Serial v2.4
    Jul 26 09:28:42 kernel: [    4.426751] g_serial gadget: g_serial ready
    Jul 26 09:28:42 kernel: [    4.515893] EXT4-fs (mmcblk0p1): re-mounted. Opts: (null)
    Jul 26 09:28:42 kernel: [    4.531486] (stk) :ldisc installation timeout
    Jul 26 09:28:42 kernel: [    4.535681] (stk) :ldisc_install = 0<6>[    4.739749] wlcore: wl18xx HW: 183x or 180x, PG 2.2 (ROM 0x11)
    Jul 26 09:28:42 kernel: [    4.760537] wlcore: loaded
    Jul 26 09:28:42 kernel: [    4.769412] wlcore: driver version: R8.7_SP3
    Jul 26 09:28:42 kernel: [    5.531029] (stk) : timed out waiting for ldisc to be un-installed
    Jul 26 09:28:42 kernel: [    5.646105] (stk) :ldisc_install = 1(stc): st_tty_open 
    Jul 26 09:28:42 kernel: [    5.704808] (stk) :line discipline installed(stk) :ti-connectivity/TIInit_11.8.32.bts
    Jul 26 09:28:42 kernel: [    5.722285] (stk) :change remote baud rate command in firmware(stk) :skipping the wait event of change remote baud
    Jul 26 09:28:42 kernel: [    6.448304] wlcore: PHY firmware version: Rev 8.2.0.0.242
    Jul 26 09:28:42 kernel: [    6.568028] wlcore: firmware booted (Rev 8.9.0.0.79)
    Jul 26 09:28:42 kernel: [    6.674571] random: nonblocking pool is initialized
    Jul 26 09:28:42 kernel: [    9.016457] (stc): add_channel_to_table: id 4
    Jul 26 09:28:42 kernel: [    9.020879] (stc): add_channel_to_table: id 2
    Jul 26 09:28:42 kernel: [    9.025416] (stc): add_channel_to_table: id 3
    Jul 26 09:28:42 kernel: [   10.773584] wlan0: authenticate with b8:ec:a3:ec:ba:ef
    Jul 26 09:28:42 kernel: [   10.786040] wlan0: send auth to b8:ec:a3:ec:ba:ef (try 1/3)
    Jul 26 09:28:42 kernel: [   10.813988] wlan0: authenticated
    Jul 26 09:28:42 kernel: [   10.821032] wlan0: associate with b8:ec:a3:ec:ba:ef (try 1/3)
    Jul 26 09:28:42 kernel: [   10.834894] wlan0: RX AssocResp from b8:ec:a3:ec:ba:ef (capab=0x431 status=0 aid=1)
    Jul 26 09:28:42 kernel: [   10.848919] wlan0: associated
    Jul 26 09:28:42 kernel: [   11.101159] wlcore: Association completed.
    Jul 26 09:28:42 kernel: [   11.321236] (stc): remove_channel_from_table: id 3
    Jul 26 09:28:42 kernel: [   11.326087] (stc): remove_channel_from_table: id 2
    Jul 26 09:28:42 kernel: [   11.330911] (stc): remove_channel_from_table: id 4
    Jul 26 09:28:42 kernel: [   11.335814] (stc):  all chnl_ids unregistered 
    Jul 26 09:28:42 kernel: [   11.340170] (stk) :ldisc_install = 0(stc): st_tty_close 
    Jul 26 09:28:42 kernel: [   15.073465] mrf24j40 spi1.0: probe(). IRQ: 44
    Jul 26 09:28:42 kernel: [   16.397734] NET: Registered protocol family 10
    Jul 26 09:28:42 kernel: [   17.826512] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
    Jul 26 09:28:42 kernel: [   17.835943] Bluetooth: BNEP filters: protocol multicast
    Jul 26 09:28:42 kernel: [   17.841964] Bluetooth: BNEP socket layer initialized
    Jul 26 09:28:42 avahi-daemon[470]: Found user 'avahi' (UID 998) and group 'avahi' (GID 996).
    Jul 26 09:28:42 avahi-daemon[470]: Successfully dropped root privileges.
    Jul 26 09:28:42 avahi-daemon[470]: avahi-daemon 0.7 starting up.
    Jul 26 09:28:42 avahi-daemon[470]: Successfully called chroot().
    Jul 26 09:28:42 avahi-daemon[470]: Successfully dropped remaining capabilities.
    Jul 26 09:28:42 avahi-daemon[470]: Loading service file /services/sftp-ssh.service.
    Jul 26 09:28:42 avahi-daemon[470]: Loading service file /services/ssh.service.
    Jul 26 09:28:42 avahi-daemon[470]: Joining mDNS multicast group on interface lowpan0.IPv6 with address fe80::668d:6e63:8a5:7b9e.
    Jul 26 09:28:42 avahi-daemon[470]: New relevant interface lowpan0.IPv6 for mDNS.
    Jul 26 09:28:42 avahi-daemon[470]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::7a04:73ff:feed:ffe7.
    Jul 26 09:28:42 avahi-daemon[470]: New relevant interface wlan0.IPv6 for mDNS.
    Jul 26 09:28:42 avahi-daemon[470]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.34.
    Jul 26 09:28:42 avahi-daemon[470]: New relevant interface wlan0.IPv4 for mDNS.
    Jul 26 09:28:42 avahi-daemon[470]: Network interface enumeration completed.
    Jul 26 09:28:42 avahi-daemon[470]: Registering new address record for fe80::668d:6e63:8a5:7b9e on lowpan0.*.
    Jul 26 09:28:42 avahi-daemon[470]: Registering new address record for fe80::7a04:73ff:feed:ffe7 on wlan0.*.
    Jul 26 09:28:42 avahi-daemon[470]: Registering new address record for 192.168.1.34 on wlan0.IPv4.
    Jul 26 09:28:42 crond[482]: (CRON) STARTUP (1.5.2)
    Jul 26 09:28:42 crond[482]: (CRON) INFO (Syslog will be used instead of sendmail.)
    Jul 26 09:28:42 crond[482]: (CRON) INFO (RANDOM_DELAY will be scaled with factor 48% if used.)
    Jul 26 09:28:43 avahi-daemon[470]: Server startup complete. Host name is.local. Local service cookie is 2985462976.
    Jul 26 09:28:44 avahi-daemon[470]: Service "vesta" (/services/ssh.service) successfully established.
    Jul 26 09:28:44 avahi-daemon[470]: Service "vesta" (/services/sftp-ssh.service) successfully established.
    Jul 26 09:28:48 kernel: [   23.811584] wlcore: WARNING no fw rx ba on tid 6
    Jul 26 09:28:53 chronyd[452]: Selected source 5.148.175.134
    Jul 26 09:28:53 kernel: [   29.285738] wlcore: WARNING no fw rx ba on tid 6
    Jul 26 09:28:53 chronyd[452]: Selected source 185.17.70.106
    Jul 26 09:28:54 chronyd[452]: Source 195.186.1.100 replaced with 192.33.96.102
    Jul 26 09:28:57 kernel: [   33.883138] wlcore: WARNING no fw rx ba on tid 6
    Jul 26 09:30:01 CROND[584]: (root) CMD (       cd /etc && ./update-timestamp.sh)
    Jul 26 09:32:01 CROND[587]: (root) CMD (       cd /etc && ./update-timestamp.sh)
    Jul 26 09:32:09 chronyd[452]: Selected source 217.147.223.78
    Jul 26 09:34:01 CROND[594]: (root) CMD (       cd /etc && ./update-timestamp.sh)
    Jul 26 09:36:01 CROND[602]: (root) CMD (       cd /etc && ./update-timestamp.sh)
    Jul 26 09:36:27 chronyd[452]: Selected source 192.33.96.102
    Jul 26 09:38:01 CROND[605]: (root) CMD (       cd /etc && ./update-timestamp.sh)
    


  • The issue still happen quite often on a lot of devices. The devices are connected:

    ping -c 4 google.com
    PING google.com (172.217.23.110) 56(84) bytes of data.
    64 bytes from fra16s45-in-f14.1e100.net (172.217.23.110): icmp_seq=1 ttl=51 time=196 ms
    64 bytes from fra16s45-in-f14.1e100.net (172.217.23.110): icmp_seq=2 ttl=51 time=175 ms
    64 bytes from fra16s45-in-f14.1e100.net (172.217.23.110): icmp_seq=3 ttl=51 time=638 ms
    64 bytes from fra16s45-in-f14.1e100.net (172.217.23.110): icmp_seq=4 ttl=51 time=197 ms
    
    --- google.com ping statistics ---
    4 packets transmitted, 4 received, 0% packet loss, time 1002ms
    rtt min/avg/max/mdev = 174.690/301.226/637.715/194.471 ms
    

    But the QNetworkAccessManager doesn't work.


Log in to reply