[ 6.537072@1] Key type dns_resolver registered [ 6.542470@1] Registering SWP/SWPB emulation handler [ 6.547371@1] regulator-dummy: disabling [ 6.551860@1] console [netcon0] enabled [ 6.556067@1] netconsole: network logging started [ 6.560295@1] aml_vrtc rtc.29: setting system clock to 2015-01-01 00:00:09 UTC (1420070409) [ 6.568259@1] cpufreq-scpi cpufreq-meson.7: enter cpufreq [ 6.573061@1] cpufreq-scpi cpufreq-meson.7: probe cpufreq okay [ 6.579331@1] gxbb_pm: enter meson_pm_probe! [ 6.583683@1] gxbb_pm: meson_pm_probe done [ 6.588466@0] cpucore_cooling_register, max_cpu_core_num:4 [ 6.607993@0] ALSA device list: [ 6.612222@0] #0: AML-M8AUDIO [ 6.616740@0] Freeing unused kernel memory: 736K (ffffffc001a4f000 - ffffffc001b07000) [ 6.665308@3] fb: osd[0] enable: 1 (platform_init) [ 6.726023@2] fb: osd[0] canvas.idx =0x40 [ 6.726026@2] fb: osd[0] canvas.addr=0x7e700000 [ 6.726028@2] fb: osd[0] canvas.width=7680 [ 6.726029@2] fb: osd[0] canvas.height=2160 [ 6.726031@2] fb: osd[0] frame.width=1920 [ 6.726033@2] fb: osd[0] frame.height=1080 [ 6.771460@2] fb: Frame buffer memory assigned at [ 6.771473@2] fb: 1, phy: 0x000000007ff00000, vir:0xffffff8003380000, size=1024K [ 6.771473@2] [ 6.771480@2] fb: fb1 open, logo index:1 [ 6.771806@0] vfm_map_store:rm default [ 6.771806@0] [ 6.771864@0] vfm_map_store:add default decoder ppmgr deinterlace amvideo [ 6.771864@0] [ 6.840203@3] EXT4-fs (mmcblk0p13): couldn't mount as ext3 due to feature incompatibilities [ 6.840435@3] EXT4-fs (mmcblk0p13): couldn't mount as ext2 due to feature incompatibilities [ 6.843054@1] EXT4-fs (mmcblk0p13): mounted filesystem with ordered data mode. Opts: (null) [ 6.999285@3] EXT4-fs (mmcblk0p14): couldn't mount as ext3 due to feature incompatibilities [ 6.999529@3] EXT4-fs (mmcblk0p14): couldn't mount as ext2 due to feature incompatibilities [ 7.002501@3] EXT4-fs (mmcblk0p14): mounted filesystem with ordered data mode. Opts: (null) [ 8.122416@2] systemd[1]: System time before build time, advancing clock. [ 8.129530@2] systemd[1]: systemd 232 running in system mode. (-PAM -AUDIT -SELINUX -IMA -APPARMOR -SMACK -SYSVINIT -UTMP -LIBCRYPTSETUP -GCRYPT -GNUTLS -ACL -XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN) [ 8.129772@2] systemd[1]: Detected architecture arm64. [ 8.129921@2] systemd[1]: Set hostname to . [ 8.177912@2] systemd[1]: Listening on udev Control Socket. [ 8.178081@2] systemd[1]: Reached target Swap. [ 8.178184@2] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ 8.178298@2] systemd[1]: Listening on Journal Socket. [ 8.178614@2] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ 8.178655@2] systemd[1]: Reached target Paths. [ 8.178745@2] systemd[1]: Listening on udev Kernel Socket. [ 8.178825@2] systemd[1]: Listening on Journal Socket (/dev/log). [ 8.179298@2] systemd[1]: Created slice User and Session Slice. [ 8.179530@2] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe. [ 8.179760@2] systemd[1]: Listening on RPCbind Server Activation Socket. [ 8.179800@2] systemd[1]: Reached target RPC Port Mapper. [ 8.180012@2] systemd[1]: Created slice System Slice. [ 8.181134@2] systemd[1]: Mounting POSIX Message Queue File System... [ 8.183853@2] systemd[1]: Starting Load Kernel Modules... [ 8.185298@2] systemd[1]: Mounting Debug File System... [ 8.185430@2] systemd[1]: Reached target Slices. [ 8.188233@2] systemd[1]: Mounting Variable Directory... [ 8.191967@2] systemd[1]: Starting Create list of required static device nodes for the current kernel... [ 8.193432@2] systemd[1]: Mounting Temporary Directory... [ 8.195518@2] systemd[1]: Starting Remount Root and Kernel File Systems... [ 8.197050@2] systemd[1]: Starting Show Version... [ 8.199287@2] systemd[1]: Starting Debug Shell on /dev/ttyS0... [ 8.200847@2] systemd[1]: Starting Setup machine-id... [ 8.205082@2] systemd[1]: Mounted Debug File System. [ 8.205255@2] systemd[1]: Mounted POSIX Message Queue File System. [ 8.205326@2] systemd[1]: Mounted Variable Directory. [ 8.205394@2] systemd[1]: Mounted Temporary Directory. [ 8.206903@2] systemd[1]: Started Remount Root and Kernel File Systems. [ 8.208259@2] meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 [ 8.212479@2] systemd[1]: Starting udev Coldplug all Devices... [ 8.218201@2] systemd[1]: Starting Setup Timezone data... [ 8.219642@2] systemd[1]: Started Create list of required static device nodes for the current kernel. [ 8.220265@2] systemd[1]: Started Show Version. [ 8.221793@2] systemd[1]: Started Debug Shell on /dev/ttyS0. [ 8.222531@2] systemd[1]: Started Setup machine-id. [ 8.223332@1] meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 [ 8.225567@2] systemd[1]: Starting Journal Service... [ 8.227378@2] systemd[1]: Starting Create Static Device Nodes in /dev... [ 8.235003@0] cfg80211: Calling CRDA to update world regulatory domain [ 8.241929@2] systemd[1]: Started Setup Timezone data. [ 8.258311@1] systemd[1]: Started Create Static Device Nodes in /dev. [ 8.258765@1] systemd[1]: Reached target Local File Systems (Pre). [ 8.258834@1] systemd[1]: Reached target Local File Systems. [ 8.269683@0] dhd_module_init: in [ 8.269707@0] ======== bcm_wlan_set_plat_data ======== [ 8.269710@0] host_oob_irq: 100 [ 8.269713@0] host_oob_irq_flags=1044 [ 8.269716@0] dhd_wifi_platform_load: Enter [ 8.269731@0] Power-up adapter 'DHD generic adapter' [ 8.269735@0] wifi_platform_set_power = 1 [ 8.269741@0] ======== PULL WL_REG_ON HIGH! ======== [ 8.269758@0] aml_wifi wifi.30: [extern_wifi_set_enable] WIFI Disable! 234 [ 8.318072@1] systemd[1]: Started Journal Service. [ 8.331393@2] systemd-journald[1748]: Received request to flush runtime journal from PID 1 [ 8.469816@0] aml_wifi wifi.30: [extern_wifi_set_enable] WIFI Enable! 234 [ 8.978380@0] wifi_platform_bus_enumerate device present 1 [ 8.978398@0] ======== Card detection to detect SDIO card! ======== [ 9.000757@0] sdio: queuing unknown CIS tuple 0x80 (2 bytes) [ 9.003259@0] sdio: queuing unknown CIS tuple 0x80 (3 bytes) [ 9.005750@0] sdio: queuing unknown CIS tuple 0x80 (3 bytes) [ 9.010341@0] sdio: queuing unknown CIS tuple 0x80 (7 bytes) [ 9.081648@0] sdio: new high speed SDIO card at address 0001 [ 9.081659@0] sdio: clock 50000000, 4-bit-bus-width [ 9.081659@0] [ 9.082067@0] [sdio_reinit] finish [ 9.098440@0] bcmsdh_register: register client driver [ 9.098536@0] bcmsdh_sdmmc: bcmsdh_sdmmc_probe Enter [ 9.098581@0] bcmsdh_sdmmc: bcmsdh_sdmmc_probe Enter [ 9.098585@0] bus num (host idx)=0, slot num (rca)=1 [ 9.098589@0] found adapter info 'DHD generic adapter' [ 9.098804@0] dhdsdio_probe : no mutex held. set lock [ 9.098876@0] F1 signature read @0x18000000=0x16044330 [ 9.100545@0] F1 signature OK, socitype:0x1 chip:0x4330 rev:0x4 pkg:0x0 [ 9.100867@0] DHD: dongle ram size is set to 294912(orig 294912) at 0x0 [ 9.101042@0] dhd_conf_set_chiprev: chip=0x4330, chiprev=4 [ 9.101077@0] dhd_conf_set_conf_path_by_nv_path: config_path=/lib/firmware/brcm/config.txt [ 9.102837@0] dhd_conf_read_nv_by_chip: nv_by_chip_count=2 [ 9.102847@0] dhd_conf_read_nv_by_chip: chip=0x4330, chiprev=4, name=nvram_ap6330.txt [ 9.102852@0] dhd_conf_read_nv_by_chip: chip=0x4339, chiprev=1, name=nvram_ap6335.txt [ 9.102865@0] dhd_conf_read_config: mimo_bw_cap = 1 [ 9.102963@0] dhd_conf_read_config: kso_enable = 0 [ 9.103028@0] dhd_conf_read_config: PM = 0 [ 9.103517@0] wl_create_event_handler(): thread:wl_event_handler:953 started [ 9.103524@3] tsk Enter, tsk = 0xffffff80008e3940 [ 9.103664@0] dhd_attach(): thread:dhd_watchdog_thread:955 started [ 9.103689@0] dhd_attach(): thread:dhd_dpc:956 started [ 9.103701@1] dhd_dpc_thread: set dpc_cpucore 0 from config.txt [ 9.103727@0] dhd_attach(): thread:dhd_rxf:957 started [ 9.103737@0] dhd_deferred_work_init: work queue initialized [ 9.103819@0] dhdsdio_probe_init: set use_rxchain 0 from config.txt [ 9.111977@0] Dongle Host Driver, version 1.201.59.5 (r506368) [ 9.111977@0] Compiled in drivers/net/wireless/bcmdhd [ 9.112553@0] Register interface [wlan0] MAC: 44:2c:05:58:6f:ea [ 9.112553@0] [ 9.112561@0] dhd_prot_ioctl : bus is down. we have nothing to do [ 9.112602@0] bcmsdh_oob_intr_unregister: Enter [ 9.112606@0] bcmsdh_oob_intr_unregister: irq is not registered [ 9.112613@0] dhd_txglom_enable: enable 0 [ 9.112616@0] dhd_bus_devreset: WLAN OFF DONE [ 9.112648@0] wifi_platform_set_power = 0 [ 9.112652@0] ======== PULL WL_REG_ON LOW! ======== [ 9.112656@0] dhdsdio_probe : the lock is released. [ 9.112734@0] dhd_module_init: Exit err=0 [ 9.121814@0] mali-utgard d00c0000.mali: set min pp to default 1 [ 9.121825@0] mali-utgard d00c0000.mali: set min clk default to 0 [ 9.121905@0] mali-utgard d00c0000.mali: max clk set 5 [ 9.121910@0] mali-utgard d00c0000.mali: turbo clk set to 6 [ 9.123630@0] gpu cooling register okay with err=0 [ 9.123725@0] gpu core cooling register okay with err=0 [ 9.123979@0] Mali: Mali device driver loaded [ 9.124580@0] wetekdvb: module license 'Proprietary' taints kernel. [ 9.124588@0] Disabling lock debugging due to kernel taint [ 9.125090@0] DVB: registering new adapter (wetek) [ 9.125106@0] wetek-dvb dvb.49: DVB: registering adapter 0 frontend 0 (Availink AVL6211+AV2011 DVB-S/S2)... [ 9.448207@1] Console: switching to colour dummy device 80x25 [ 9.545512@0] remote: cur_mode = 0 [ 9.545525@0] remote: set_remote_mode[74] [ 9.635288@2] usbcore: registered new interface driver ftdi_sio [ 9.661543@2] usbserial: USB Serial support registered for FTDI USB Serial Device [ 9.661653@2] ftdi_sio 1-1.4:1.0: FTDI USB Serial Device converter detected [ 9.674442@2] usb 1-1.4: Detected FT232RL [ 9.674446@2] usb 1-1.4: Number of endpoints 2 [ 9.674449@2] usb 1-1.4: Endpoint 1 MaxPacketSize 64 [ 9.674451@2] usb 1-1.4: Endpoint 2 MaxPacketSize 64 [ 9.674454@2] usb 1-1.4: Setting MaxPacketSize 64 [ 9.720946@2] usb 1-1.4: FTDI USB Serial Device converter now attached to ttyUSB0 [ 9.842995@3] meson_uart c11084c0.serial: ttyS1 use xtal(8M) 24000000 change 0 to 9600 [ 9.843041@3] meson_uart c11084c0.serial: ttyS1 use xtal(8M) 24000000 change 9600 to 9600 [ 9.843062@3] meson_uart c11084c0.serial: ttyS1 use xtal(8M) 24000000 change 9600 to 115200 [ 9.847828@1] meson_uart c11084c0.serial: ttyS1 use xtal(8M) 24000000 change 115200 to 2000000 [ 9.930117@1] 8021q: 802.1Q VLAN Support v1.8 [ 9.944616@2] dhd_open: Enter ffffffc073d1d000 [ 9.944631@2] [ 9.944631@2] Dongle Host Driver, version 1.201.59.5 (r506368) [ 9.944631@2] Compiled in drivers/net/wireless/bcmdhd [ 9.944638@2] wl_android_wifi_on in 1 [ 9.944641@2] wl_android_wifi_on in 2: g_wifi_on=0 [ 9.944645@2] wifi_platform_set_power = 1 [ 9.944649@2] ======== PULL WL_REG_ON HIGH! ======== [ 9.944669@2] aml_wifi wifi.30: [extern_wifi_set_enable] WIFI Disable! 234 [ 10.144735@2] aml_wifi wifi.30: [extern_wifi_set_enable] WIFI Enable! 234 [ 10.228926@0] meson_uart c11084c0.serial: ttyS1 use xtal(8M) 24000000 change 2000000 to 115200 [ 10.267164@0] meson_uart c11084c0.serial: ttyS1 use xtal(8M) 24000000 change 115200 to 2000000 [ 10.290847@0] Bluetooth: Core ver 2.18 [ 10.290968@0] NET: Registered protocol family 31 [ 10.290972@0] Bluetooth: HCI device and connection manager initialized [ 10.290996@0] Bluetooth: HCI socket layer initialized [ 10.291002@0] Bluetooth: L2CAP socket layer initialized [ 10.648383@2] sdio_reset_comm(): [ 10.667198@0] sdio: queuing unknown CIS tuple 0x80 (2 bytes) [ 10.669708@0] sdio: queuing unknown CIS tuple 0x80 (3 bytes) [ 10.672207@0] sdio: queuing unknown CIS tuple 0x80 (3 bytes) [ 10.676701@0] sdio: queuing unknown CIS tuple 0x80 (7 bytes) [ 10.690616@0] aml_spdif_dai: aml_hw_iec958_init,runtime->rate=44100, runtime->channels=2, same source mode(1) [ 10.690663@0] aml_spdif_dai: share the same clock [ 10.690672@0] aml_audio_hw: IEC958 PCM32 [ 10.690677@0] hdmitx: audio: aout notify rate 44100 [ 10.690681@0] hdmitx: audio: aout notify size 32 [ 10.690684@0] hdmitx: audio: aout notify format CT_PCM [ 10.690688@0] hdmtix: set audio [ 10.690700@0] hdmitx tx_aud_src = 0 [ 10.690725@0] hdmitx: fs = 2, cd = 4, tmds_clk = 148500 [ 10.690729@0] hdmitx aud_n_para = 6272 [ 10.690819@0] hdmitx set channel status [ 10.690878@0] hdmitx: audio: Audio Type: PCM [ 10.690881@0] hdmitx: audio: set audio param [ 10.690890@0] aml_snd_m8_card aml_m8_snd.45: i2s/958 same source [ 10.691032@0] aml_snd_card: audio speaker on [ 10.700101@0] aml_spdif_dai: aml_hw_iec958_init,runtime->rate=44100, runtime->channels=2, same source mode(1) [ 10.700109@0] aml_spdif_dai: share the same clock [ 10.700117@0] aml_audio_hw: IEC958 PCM32 [ 10.700123@0] hdmitx: audio: aout notify rate 44100 [ 10.700126@0] hdmitx: audio: aout notify size 32 [ 10.700130@0] hdmitx: audio: no update [ 10.700139@0] aml_snd_m8_card aml_m8_snd.45: i2s/958 same source [ 10.700414@0] channel count should be 8, we got 2 aborting [ 10.705658@0] aml_snd_m8_card aml_m8_snd.45: I2S playback enable [ 10.705673@0] aml_snd_m8_card aml_m8_snd.45: IEC958 playback enable [ 10.751341@0] [ 10.751341@0] [ 10.751341@0] dhd_bus_devreset: == WLAN ON == [ 10.751420@0] F1 signature read @0x18000000=0x16044330 [ 10.753060@0] F1 signature OK, socitype:0x1 chip:0x4330 rev:0x4 pkg:0x0 [ 10.753363@0] DHD: dongle ram size is set to 294912(orig 294912) at 0x0 [ 10.753563@0] dhdsdio_probe_init: set use_rxchain 0 from config.txt [ 10.753705@0] dhd_conf_read_nv_by_chip: nv_by_chip_count=2 [ 10.753710@0] dhd_conf_read_nv_by_chip: chip=0x4330, chiprev=4, name=nvram_ap6330.txt [ 10.753714@0] dhd_conf_read_nv_by_chip: chip=0x4339, chiprev=1, name=nvram_ap6335.txt [ 10.753729@0] dhd_conf_read_config: mimo_bw_cap = 1 [ 10.753826@0] dhd_conf_read_config: kso_enable = 0 [ 10.753891@0] dhd_conf_read_config: PM = 0 [ 10.753905@0] dhd_conf_set_fw_name_by_chip: firmware_path=/lib/firmware/brcm/fw_bcm40183b2.bin [ 10.753909@0] dhd_conf_set_nv_name_by_chip: nvram_path=/lib/firmware/brcm/nvram_ap6330.txt [ 10.753912@0] Final fw_path=/lib/firmware/brcm/fw_bcm40183b2.bin [ 10.753915@0] Final nv_path=/lib/firmware/brcm/nvram_ap6330.txt [ 10.753918@0] Final conf_path=/lib/firmware/brcm/config.txt [ 10.782419@0] NVRAM version: AP6330_NVRAM_V1.0_20121130 [ 10.782806@0] dhdsdio_write_vars: Download, Upload and compare of NVRAM succeeded. [ 10.849060@0] fb: osd[0] enable: 1 (kodi.bin) [ 11.047743@0] dhd_bus_init: enable 0x06, ready 0x06 (waited 0us) [ 11.047835@0] bcmsdh_oob_intr_register: Enter [ 11.047839@0] bcmsdh_oob_intr_register: HW_OOB enabled [ 11.047842@0] bcmsdh_oob_intr_register OOB irq=100 flags=414 [ 11.047867@0] bcmsdh_oob_intr_register: enable_irq_wake [ 11.047872@0] bcmsdh_oob_intr_register: enable_irq_wake failed with -6 [ 11.049327@0] dhd_conf_set_band: Set band 0 [ 11.049482@0] dhd_preinit_ioctls: Set tcpack_sup_mode 0 [ 11.050979@0] Firmware up: op_mode=0x0005, MAC=44:2c:05:58:6f:ea [ 11.050984@0] dhd_conf_set_country: Set country CN, revision 38 [ 11.051277@0] dhd_conf_set_country: country code setting failed -2 [ 11.052280@0] Country code: ALL (ALL/0) [ 11.052529@0] dhd_conf_set_roam: Set roam_off 1 [ 11.053612@0] dhd_conf_set_mimo_bw_cap: Set mimo_bw_cap 1 [ 11.053839@0] CONFIG-ERROR) dhd_conf_set_mimo_bw_cap: mimo_bw_cap setting failed -23 [ 11.054564@0] dhd_preinit_ioctls buf_key_b4_m4 set failed -23 [ 11.059906@0] Firmware version = wl0: Jan 6 2014 15:11:29 version 5.90.195.89.13 FWID 01-72f124c5 [ 11.059916@0] Driver: 1.201.59.5 (r506368) [ 11.059916@0] Firmware: wl0: Jan 6 2014 15:11:29 version 5.90.195.89.13 FWID 01-72f124c5 [ 11.060101@0] dhd_txglom_enable: enable 0 [ 11.060105@0] dhd_conf_set_disable_proptx: set disable_proptx 1 [ 11.060613@0] dhd_preinit_ioctls wl ampdu_hostreorder failed -23 [ 11.060965@0] wl_android_wifi_on: Success [ 11.145131@0] dhd_set_scb_probe: GET max_scb_probe failed [ 11.145483@0] dhd_set_scb_probe: max_scb_probe setting failed [ 11.145489@0] dhd_open: Exit ret=0 [ 11.145995@0] Bluetooth: SCO socket layer initialized [ 11.150394@0] Bluetooth: HCI UART driver ver 2.2 [ 11.150406@0] Bluetooth: HCI H4 protocol initialized [ 11.150409@0] Bluetooth: HCI BCSP protocol initialized [ 11.150412@0] Bluetooth: HCILL protocol initialized [ 11.150415@0] Bluetooth: HCIATH3K protocol initialized [ 13.899029@2] libphy: stmmac-0:00 - Link is Up - 1000/Full [ 13.899215@2] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 70.937449@0] aml_snd_m8_card aml_m8_snd.45: I2S playback disable [ 70.937454@0] aml_snd_m8_card aml_m8_snd.45: IEC958 playback disable [ 70.937517@0] aml_spdif_dai: aml_hw_iec958_init,runtime->rate=44100, runtime->channels=2, same source mode(1) [ 70.937520@0] aml_spdif_dai: share the same clock [ 70.937527@0] aml_audio_hw: IEC958 PCM32 [ 70.937532@0] hdmitx: audio: aout notify rate 44100 [ 70.937534@0] hdmitx: audio: aout notify size 32 [ 70.937536@0] hdmitx: audio: no update [ 70.937541@0] aml_snd_m8_card aml_m8_snd.45: i2s/958 same source [ 85.937252@0] aml_snd_card: audio speaker off [ 150.481151@2] i2c i2c-1: [aml_i2c_xfer] error ret = -5 (-EIO) [ 150.481164@2] i2c i2c-1: token 0, master_no(1) 300K addr 0xc [ 150.481218@2] i2c i2c-1: [aml_i2c_xfer] error ret = -5 (-EIO) [ 150.481223@2] i2c i2c-1: token 1, master_no(1) 300K addr 0xc [ 150.481496@2] i2c i2c-1: [aml_i2c_xfer] error ret = -5 (-EIO) [ 150.481501@2] i2c i2c-1: token 0, master_no(1) 300K addr 0xc [ 150.481506@2] i2c i2c-1: i2c wr failed=-11 [ 151.811042@0] wetek-dvb dvb.49: DVB: adapter 0 frontend 0 frequency 0 out of range (950000..2150000) [ 437.057402@0] aml_spdif_dai: aml_hw_iec958_init,runtime->rate=48000, runtime->channels=2, same source mode(1) [ 437.057405@0] aml_spdif_dai: share the same clock [ 437.057414@0] aml_audio_hw: IEC958 PCM32 [ 437.057419@0] hdmitx: audio: aout notify rate 48000 [ 437.057420@0] hdmitx: audio: aout notify size 32 [ 437.057423@0] hdmtix: set audio [ 437.057437@0] hdmitx tx_aud_src = 0 [ 437.057463@0] hdmitx: fs = 3, cd = 4, tmds_clk = 148500 [ 437.057466@0] hdmitx aud_n_para = 6144 [ 437.057484@0] hdmitx set channel status [ 437.057543@0] hdmitx: audio: Audio Type: PCM [ 437.057546@0] hdmitx: audio: set audio param [ 437.057557@0] aml_snd_m8_card aml_m8_snd.45: i2s/958 same source [ 437.057662@0] aml_snd_card: audio speaker on [ 437.059260@1] vfm_map_store:rm default [ 437.059294@1] vfm_map_store:add default [ 437.060410@1] vfm_map_store:rm default [ 437.060441@1] vfm_map_store:add default decoder ppmgr deinterlace amlvideo amvideo [ 437.060996@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [ 437.063724@0] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [ 437.066657@0] aml_spdif_dai: aml_hw_iec958_init,runtime->rate=48000, runtime->channels=2, same source mode(1) [ 437.066660@0] aml_spdif_dai: share the same clock [ 437.066668@0] aml_audio_hw: IEC958 PCM32 [ 437.066673@0] hdmitx: audio: aout notify rate 48000 [ 437.066674@0] hdmitx: audio: aout notify size 32 [ 437.066676@0] hdmitx: audio: no update [ 437.066685@0] aml_snd_m8_card aml_m8_snd.45: i2s/958 same source [ 437.066783@0] channel count should be 8, we got 2 aborting [ 437.067875@0] aml_snd_m8_card aml_m8_snd.45: I2S playback enable [ 437.067880@0] aml_snd_m8_card aml_m8_snd.45: IEC958 playback enable [ 437.076597@0] DI: di_receiver_event_fun: vframe provider reg [ 437.086785@0] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [ 437.086788@0] tv_vout: vout [framerate_automation_process] duration = 3840 [ 437.086790@0] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [ 437.086792@0] tv_vout: fr_vsource = 2500 [ 437.086798@0] tv_vout: mode_target=16,is_receiver_supported=1 [ 437.087314@0] codec:video first pts = 0 [ 437.088621@0] [tsync_avevent]event:1, param 1 [ 437.088625@0] video pause! [ 437.089027@0] codec:video first checkin pts = 220aa [ 437.089029@0] codec:first check in vpts <0x94:0x220aa> ok! [ 437.089217@0] codec:Enter set parameter cmd1. [ 437.090290@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [ 437.090296@0] codec:actual_dpb_size 15 max_dpb_size 5 [ 437.090347@0] codec:video first pts = 220aa [ 437.206549@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [ 437.256502@1] ***** DI ****** wait 1 pre_de_irq timeout [ 438.891157@0] vpts to scr, apts = 0x0, vpts = 0x220aa [ 438.891635@3] rdma_register, rdma_table_addr ffffff8003327000 rdma_table_addr_phy 762d2000 reg_buf ffffffc050c7c000 [ 438.891645@3] rdma_register success, handle 2 table_size 8192 [ 438.892198@1] vout_serve: vmode set to 1080p50hz [ 438.892225@1] fb: current vmode=1080p60hz [ 438.892234@1] tv_vout: tv_set_current_vmode[764]fps_target_mode=18 [ 438.892241@1] tv_vout: mode is 18,sync_duration_den=1,sync_duration_num=50 [ 438.892250@1] tv_vout: TV mode 1080p50hz selected. [ 438.892256@1] [ 438.892256@1] vdac_enable: on:0,module_sel:8 [ 438.892267@1] [ 438.892267@1] vdac_enable: on:0,module_sel:8 [ 438.892277@1] tv_vout: new mode =1080p50hz set ok [ 438.892282@1] vout_serve: vinfo mode is: 1080p50hz [ 438.892286@1] vout_serve: new mode 1080p50hz set ok [ 438.892304@1] hdmitx: video: get current mode: 1080p50hz [ 438.892309@1] hdmitx: update rx hdr info 0 [ 438.892326@1] hdmitx: get ext_name 1080p60hz [ 438.892361@1] hdmitx: system: already init VIC = 0 Now VIC = 31 [ 438.892366@1] hdmitx: rx edid only support RGB format [ 438.892371@1] hdmitx: rx no SCDC present indicator [ 438.894383@1] hdmitx: ddc rd8b error 0x54 0x01 [ 438.896397@1] hdmitx: ddc rd8b error 0x54 0x01 [ 438.896405@1] hdmirx version is 1.4 or below [ 438.896410@1] hdmitx div40: 0 [ 438.925996@1] hdmitx: system: set mode VIC 31 (cd0,cs0,pm1,vd0,1) [ 438.926007@1] hdmitx: system: set pll [ 438.926011@1] hdmitx: system: param->VIC:31 [ 438.926016@1] hdmitx: set clk: VIC = 31 cd = 4 [ 438.926024@1] config HPLL = 2970000 [ 438.926047@1] HPLL: 0xc800023d [ 438.926051@1] config HPLL done [ 438.926060@1] set_hpll_od3_clk_div[441] div = 6 [ 438.926072@1] j = 4 vid_clk_div = 1 [ 438.926086@1] hdmitx: set enc for VIC: 31 [ 438.926109@1] hdmitx_set_hw[4867] set VIC = 31 [ 438.926329@0] hdmitx: system: irq 80000001 [ 438.926350@0] Start = 0x10000100 End = 0x100001ff [ 438.926363@0] [0x10000104]: 0x00000001 [ 438.926558@0] [0x10000180]: 0x000000ff [ 438.926564@0] [0x10000181]: 0x000000ff [ 438.926570@0] [0x10000182]: 0x00000003 [ 438.926575@0] [0x10000183]: 0x00000007 [ 438.926581@0] [0x10000184]: 0x0000003f [ 438.926587@0] [0x10000185]: 0x00000002 [ 438.926594@0] [0x10000187]: 0x000000ff [ 438.926600@0] [0x10000188]: 0x00000003 [ 438.938009@1] hdmitx: ddc w1b error 0x54 0x20 0x00 [ 438.940030@1] hdmitx: ddc w1b error 0x54 0x20 0x00 [ 438.942044@1] hdmitx: ddc rd8b error 0x54 0x21 [ 439.057983@1] hdmitx: system: phy setting done [ 439.062006@1] Sink is HDMI device [ 439.062016@1] hdmitx: system: packet: can't get vendor data [ 439.062021@1] hdmtix: set audio [ 439.062030@1] hdmitx tx_aud_src = 0 [ 439.062055@1] hdmitx: fs = 3, cd = 4, tmds_clk = 148500 [ 439.062059@1] hdmitx aud_n_para = 6144 [ 439.062077@1] hdmitx set channel status [ 439.062135@1] hdmitx: audio: Audio Type: PCM [ 439.062160@1] fb: current vmode=1080p50hz [ 439.139344@1] fb: osd[0] enable: 1 (kodi.bin) [ 441.620377@0] vidioc_qbuf skip: index:7:4 [ 441.620468@0] vidioc_qbuf skip: index:7:5 [ 441.620485@0] vidioc_qbuf skip: index:7:6 [ 441.639012@0] codec:detect vout mode change!!!!!!!!!!!! [ 441.639074@0] codec:[video4osd] first picture {1920,1080} pts:0, [ 441.659051@0] codec:[video4osd] first picture {1920,1080} pts:266fa, [ 441.679079@0] codec:VsyncEnableVideoLayer [ 441.844133@0] codec:finished correct frame dur [ 441.844149@0] codec: new=3840,old_duration=3840,cnt=25 [ 454.002626@0] vidioc_qbuf skip: index:621:620 [ 464.539539@3] codec:video_blackout_policy_store(0) [ 464.540603@3] [tsync_avevent]event:1, param 1 [ 464.540612@3] video pause! [ 464.541309@3] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [ 464.541356@3] PPMGRVPP: info: cma free addr is 7a900000 , size is 2000000 [ 464.541404@3] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [ 464.541409@3] DI: di_receiver_event_fun: vf_notify_receiver unreg [ 464.541430@1] codec:keep exit is di [ 464.541436@1] [tsync_avevent]event:2, param 0 [ 464.541440@1] codec:video first pts = 0 [ 464.541457@0] di_uninit_buf keep cur di_buf 12 (8 3 1) [ 464.551772@3] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [ 464.552840@3] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [ 464.556358@3] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [ 464.557586@3] DI: di_receiver_event_fun: vframe provider reg [ 464.567730@3] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [ 464.567741@3] tv_vout: vout [framerate_automation_process] duration = 3840 [ 464.567746@3] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [ 464.567749@3] tv_vout: fr_vsource = 2500 [ 464.567759@3] tv_vout: mode_target=18,is_receiver_supported=1 [ 464.568250@3] codec:video first pts = 0 [ 464.569178@3] codec:video_blackout_policy_store(1) [ 483.619724@1] codec:video_blackout_policy_store(0) [ 483.619920@1] [tsync_avevent]event:1, param 1 [ 483.619942@1] video pause! [ 483.620511@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [ 483.620898@2] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [ 483.620927@2] DI: di_receiver_event_fun: vf_notify_receiver unreg [ 483.620997@1] codec:keep exit is di [ 483.621021@1] [tsync_avevent]event:2, param 0 [ 483.621041@1] codec:video first pts = 0 [ 483.621105@0] di_uninit_buf keep cur di_buf 12 (8 3 1) [ 483.631743@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [ 483.633072@1] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [ 483.643614@1] DI: di_receiver_event_fun: vframe provider reg [ 483.653773@1] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [ 483.653786@1] tv_vout: vout [framerate_automation_process] duration = 3840 [ 483.653792@1] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [ 483.653796@1] tv_vout: fr_vsource = 2500 [ 483.653807@1] tv_vout: mode_target=18,is_receiver_supported=1 [ 483.654327@1] codec:video first pts = 0 [ 483.654546@1] codec:video_blackout_policy_store(1) [ 485.459175@1] codec:DisableVideoLayer() [ 485.459621@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [ 485.459731@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [ 485.459741@1] DI: disabled, not keep buffer. [ 485.459751@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [ 485.459786@1] codec:DisableVideoLayer() [ 485.459799@1] codec:free_alloced_keep_buffer (null). (null). (null) [ 485.459821@1] codec:keep exit is di [ 485.459832@1] [tsync_avevent]event:2, param 0 [ 485.459843@1] codec:video first pts = 0 [ 485.459879@0] di_uninit_buf keep cur di_buf 12 (8 3 1) [ 485.470495@1] codec:video_disable_store(1) [ 485.470500@1] codec:DisableVideoLayer() [ 485.470538@1] vfm_map_store:rm default [ 485.470567@1] vfm_map_store:add default [ 485.474276@0] vfm_map_store:rm default [ 485.474301@0] vfm_map_store:add default [ 485.475407@0] vfm_map_store:rm default [ 485.475433@0] vfm_map_store:add default decoder ppmgr deinterlace amlvideo amvideo [ 485.475579@0] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [ 485.476047@0] DI: di_receiver_event_fun: vframe provider reg [ 485.479023@0] codec:VsyncDisableVideoLayer [ 485.486372@0] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [ 485.486376@0] tv_vout: vout [framerate_automation_process] duration = 3840 [ 485.486378@0] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [ 485.486380@0] tv_vout: fr_vsource = 2500 [ 485.486389@0] tv_vout: mode_target=18,is_receiver_supported=1 [ 485.486843@0] codec:video first pts = 0 [ 485.487015@0] [tsync_avevent]event:1, param 1 [ 485.487019@0] video pause! [ 485.487153@0] codec:video_freerun_mode_store(1) [ 485.487287@0] codec:video first checkin pts = e6e2 [ 485.487289@0] codec:first check in vpts <0x0:0xe6e2> ok! [ 485.552928@0] codec:video first pts = e6e2 [ 485.552997@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8001/720/576/0 [ 485.561878@0] codec:vdec1 video changed to 720 x 576 25 fps clk->100MHZ [ 487.084417@0] DI: recycle_keep_buffer recycle keep cur di_buf 12 ( [ 487.084422@0] DI: 8 [ 487.084426@0] DI: 3 [ 487.084430@0] DI: 1 [ 487.084431@0] DI: ) [ 487.084442@0] vidioc_qbuf skip: index:1089:1088 [ 487.084888@0] codec:video_disable_store(0) [ 487.099031@0] vpts to scr, apts = 0x0, vpts = 0xe6e2 [ 487.099068@0] codec:[video4osd] first picture {720,576} pts:0, [ 487.119056@0] codec:[video4osd] first picture {720,576} pts:11112, [ 487.139072@0] codec:VsyncEnableVideoLayer [ 510.919565@2] codec:video_blackout_policy_store(0) [ 510.919735@2] [tsync_avevent]event:1, param 1 [ 510.919771@2] video pause! [ 510.920603@2] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [ 510.921047@2] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [ 510.921074@2] DI: di_receiver_event_fun: vf_notify_receiver unreg [ 510.921149@1] codec:keep exit is di [ 510.921177@1] [tsync_avevent]event:2, param 0 [ 510.921199@1] codec:video first pts = 0 [ 510.921267@0] di_uninit_buf keep cur di_buf 6 (9 2 0) [ 510.932184@3] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [ 510.932634@3] DI: di_receiver_event_fun: vframe provider reg [ 510.942772@3] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [ 510.942784@3] tv_vout: vout [framerate_automation_process] duration = 3840 [ 510.942791@3] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [ 510.942796@3] tv_vout: fr_vsource = 2500 [ 510.942807@3] tv_vout: mode_target=18,is_receiver_supported=1 [ 510.943276@3] codec:video first pts = 0 [ 510.944196@3] codec:video_blackout_policy_store(1) [ 513.241927@2] codec:DisableVideoLayer() [ 513.242635@2] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [ 513.242824@2] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [ 513.242834@2] DI: disabled, not keep buffer. [ 513.242837@2] DI: di_receiver_event_fun: vf_notify_receiver unreg [ 513.242892@1] codec:DisableVideoLayer() [ 513.242900@1] codec:free_alloced_keep_buffer (null). (null). (null) [ 513.242905@1] codec:keep exit is di [ 513.242912@1] [tsync_avevent]event:2, param 0 [ 513.242918@1] codec:video first pts = 0 [ 513.242941@0] di_uninit_buf keep cur di_buf 6 (9 2 0) [ 513.253184@2] codec:video_disable_store(1) [ 513.253188@2] codec:DisableVideoLayer() [ 513.253221@2] vfm_map_store:rm default [ 513.253249@2] vfm_map_store:add default [ 513.253381@2] vfm_map_store:rm default [ 513.253395@2] vfm_map_store:add default [ 513.253606@2] vfm_map_store:rm default [ 513.253634@2] vfm_map_store:add default decoder ppmgr deinterlace amlvideo amvideo [ 513.253767@2] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [ 513.259015@0] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [ 513.259016@0] codec:VsyncDisableVideoLayer [ 513.272190@1] DI: di_receiver_event_fun: vframe provider reg [ 513.282316@1] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [ 513.282335@1] tv_vout: vout [framerate_automation_process] duration = 3840 [ 513.282340@1] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [ 513.282344@1] tv_vout: fr_vsource = 2500 [ 513.282359@1] tv_vout: mode_target=18,is_receiver_supported=1 [ 513.282997@1] codec:video first pts = 0 [ 513.283106@1] [tsync_avevent]event:1, param 1 [ 513.283109@1] video pause! [ 513.283223@1] codec:video_freerun_mode_store(1) [ 513.283339@1] codec:video first checkin pts = 4650 [ 513.283341@1] codec:first check in vpts <0x2f:0x4650> ok! [ 513.284839@0] codec:Enter set parameter cmd1. [ 513.286433@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [ 513.286441@0] codec:actual_dpb_size 15 max_dpb_size 5 [ 513.286502@0] codec:video first pts = 4650 [ 513.360991@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [ 514.423987@0] codec:video_disable_store(0) [ 514.426229@0] DI: recycle_keep_buffer recycle keep cur di_buf 6 ( [ 514.426232@0] DI: 9 [ 514.426234@0] DI: 2 [ 514.426236@0] DI: 0 [ 514.426236@0] DI: ) [ 514.439020@0] vpts to scr, apts = 0x0, vpts = 0x4650 [ 514.439047@0] codec:[video4osd] first picture {1920,1080} pts:5460, [ 514.459037@0] codec:[video4osd] first picture {1920,1080} pts:0, [ 514.479041@0] codec:VsyncEnableVideoLayer [ 515.725200@2] vidioc_qbuf skip: index:1102:1100 [ 515.725209@2] vidioc_qbuf skip: index:1102:1101 [ 515.934720@0] codec:finished correct frame dur [ 515.934720@0] codec: new=3840,old_duration=3840,cnt=25 [ 922.319259@3] codec:video_blackout_policy_store(0) [ 922.319326@3] [tsync_avevent]event:1, param 1 [ 922.319332@3] video pause! [ 922.319606@3] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [ 922.322246@2] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [ 922.322260@2] DI: di_receiver_event_fun: vf_notify_receiver unreg [ 922.330594@2] codec:keep exit is di [ 922.330611@2] [tsync_avevent]event:2, param 0 [ 922.330618@2] codec:video first pts = 0 [ 922.330643@0] di_uninit_buf keep cur di_buf 5 (0 6 4) [ 922.332751@2] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [ 922.334077@0] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [ 922.341969@0] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [ 922.344268@0] DI: di_receiver_event_fun: vframe provider reg [ 922.354435@0] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [ 922.354447@0] tv_vout: vout [framerate_automation_process] duration = 3840 [ 922.354451@0] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [ 922.354455@0] tv_vout: fr_vsource = 2500 [ 922.354464@0] tv_vout: mode_target=18,is_receiver_supported=1 [ 922.354967@0] codec:video first pts = 0 [ 922.355194@0] codec:video_blackout_policy_store(1) [ 924.182819@0] codec:DisableVideoLayer() [ 924.183064@0] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [ 924.183919@0] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [ 924.183931@0] DI: disabled, not keep buffer. [ 924.183936@0] DI: di_receiver_event_fun: vf_notify_receiver unreg [ 924.183969@1] codec:DisableVideoLayer() [ 924.183978@1] codec:free_alloced_keep_buffer (null). (null). (null) [ 924.183984@1] codec:keep exit is di [ 924.183990@1] [tsync_avevent]event:2, param 0 [ 924.183996@1] codec:video first pts = 0 [ 924.184017@0] di_uninit_buf keep cur di_buf 5 (0 6 4) [ 924.194815@0] codec:video_disable_store(1) [ 924.194820@0] codec:DisableVideoLayer() [ 924.194862@0] vfm_map_store:rm default [ 924.194892@0] vfm_map_store:add default [ 924.195039@0] vfm_map_store:rm default [ 924.195060@0] vfm_map_store:add default [ 924.195207@0] vfm_map_store:rm default [ 924.195228@0] vfm_map_store:add default decoder ppmgr deinterlace amlvideo amvideo [ 924.195370@0] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [ 924.199016@0] codec:VsyncDisableVideoLayer [ 924.200200@0] codec:H264 sysinfo: 720x576 duration=3840, pts_outside=1, [ 924.204450@0] DI: di_receiver_event_fun: vframe provider reg [ 924.214561@0] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [ 924.214564@0] tv_vout: vout [framerate_automation_process] duration = 3840 [ 924.214566@0] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [ 924.214567@0] tv_vout: fr_vsource = 2500 [ 924.214574@0] tv_vout: mode_target=18,is_receiver_supported=1 [ 924.214977@0] codec:video first pts = 0 [ 924.215089@0] [tsync_avevent]event:1, param 1 [ 924.215091@0] video pause! [ 924.215241@0] codec:video_freerun_mode_store(1) [ 924.215363@0] codec:video first checkin pts = 29a76 [ 924.215365@0] codec:first check in vpts <0x2b:0x29a76> ok! [ 924.216312@0] codec:Enter set parameter cmd1. [ 924.217453@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [ 924.217459@0] codec:actual_dpb_size 24 max_dpb_size 5 [ 924.217536@0] codec:video first pts = 29a76 [ 924.261989@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/720/576/0 [ 925.195215@0] codec:restart correct frame duration [ 925.195215@0] codec:new=3532,old_duration=3840,cnt=25 [ 926.221270@0] codec:video_disable_store(0) [ 926.238996@0] vpts to scr, apts = 0x0, vpts = 0x29a76 [ 926.239027@0] codec:[video4osd] first picture {720,576} pts:27046, [ 926.241162@0] DI: recycle_keep_buffer recycle keep cur di_buf 5 ( [ 926.241175@0] DI: 0 DI: 6 [ 926.241184@0] DI: 4 <7>[ 926.241189@0] DI: ) [ 926.259010@0] codec:[video4osd] first picture {720,576} pts:0, [ 926.279045@0] codec:VsyncEnableVideoLayer [ 929.200253@0] vidioc_qbuf skip: index:21448:21445 [ 929.200340@0] vidioc_qbuf skip: index:21448:21446 [ 929.200353@0] vidioc_qbuf skip: index:21448:21447 [ 929.923388@0] codec:finished correct frame dur [ 929.923405@0] codec: new=3840,old_duration=3840,cnt=25 [13012.678744@1] codec:video_blackout_policy_store(0) [13012.678790@1] [tsync_avevent]event:1, param 1 [13012.678793@1] video pause! [13012.679070@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [13012.679186@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [13012.679193@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [13012.687827@2] codec:keep exit is di [13012.687833@2] [tsync_avevent]event:2, param 0 [13012.687837@2] codec:video first pts = 0 [13012.687855@0] di_uninit_buf keep cur di_buf 8 (9 3 5) [13012.689581@1] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [13012.690684@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [13012.708419@1] codec:H264 sysinfo: 720x576 duration=3840, pts_outside=1, [13012.708419@1] DI: di_receiver_event_fun: vframe provider reg [13012.718519@1] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [13012.718522@1] tv_vout: vout [framerate_automation_process] duration = 3840 [13012.718525@1] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [13012.718527@1] tv_vout: fr_vsource = 2500 [13012.718536@1] tv_vout: mode_target=18,is_receiver_supported=1 [13012.719203@1] codec:video first pts = 0 [13012.719541@1] codec:video_blackout_policy_store(1) [13014.718660@1] codec:DisableVideoLayer() [13014.719115@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [13014.719286@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [13014.719294@1] DI: disabled, not keep buffer. [13014.719299@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [13014.719341@1] codec:DisableVideoLayer() [13014.719349@1] codec:free_alloced_keep_buffer (null). (null). (null) [13014.719356@1] codec:keep exit is di [13014.719363@1] [tsync_avevent]event:2, param 0 [13014.719372@1] codec:video first pts = 0 [13014.719400@0] di_uninit_buf keep cur di_buf 8 (9 3 5) [13014.732215@3] codec:video_disable_store(1) [13014.732222@3] codec:DisableVideoLayer() [13014.732259@3] vfm_map_store:rm default [13014.732289@3] vfm_map_store:add default [13014.732421@3] vfm_map_store:rm default [13014.732441@3] vfm_map_store:add default [13014.732580@3] vfm_map_store:rm default [13014.732600@3] vfm_map_store:add default decoder ppmgr deinterlace amlvideo amvideo [13014.732734@3] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [13014.735876@3] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [13014.735877@3] DI: di_receiver_event_fun: vframe provider reg [13014.738517@0] codec:VsyncDisableVideoLayer [13014.746021@3] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [13014.746024@3] tv_vout: vout [framerate_automation_process] duration = 3840 [13014.746026@3] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [13014.746028@3] tv_vout: fr_vsource = 2500 [13014.746036@3] tv_vout: mode_target=18,is_receiver_supported=1 [13014.746475@3] codec:video first pts = 0 [13014.746599@3] [tsync_avevent]event:1, param 1 [13014.746602@3] video pause! [13014.746723@3] codec:video_freerun_mode_store(1) [13014.746891@3] codec:video first checkin pts = 23495 [13014.746893@3] codec:first check in vpts <0x94:0x23495> ok! [13014.747072@0] codec:Enter set parameter cmd1. [13014.748128@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [13014.748135@0] codec:actual_dpb_size 15 max_dpb_size 5 [13014.748188@0] codec:video first pts = 23495 [13014.837879@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [13016.784281@2] codec:video_disable_store(0) [13016.798517@0] vpts to scr, apts = 0x0, vpts = 0x23495 [13016.798542@0] codec:[video4osd] first picture {1920,1080} pts:242a5, [13016.818534@0] codec:VsyncEnableVideoLayer [13019.318535@0] codec:[video4osd] first picture {1920,1080} pts:0, [13019.338521@0] DI: recycle_keep_buffer recycle keep cur di_buf 8 ( [13019.338533@0] DI: 9 DI: 3 [13019.338544@0] DI: 5 <7>[13019.338549@0] DI: ) [13019.338602@0] codec:VsyncEnableVideoLayer [13019.380251@0] vidioc_qbuf skip: index:625627:625626 [13019.716540@0] codec:restart correct frame duration [13019.716555@0] codec:new=4147,old_duration=3840,cnt=25 [13020.756592@0] codec:restart correct frame duration [13020.756593@0] codec:new=3993,old_duration=3840,cnt=25 [13021.877240@0] codec:restart correct frame duration [13021.877241@0] codec:new=4608,old_duration=3840,cnt=25 [13022.956340@0] codec:finished correct frame dur [13022.956341@0] codec: new=3840,old_duration=3840,cnt=25 [13025.638765@3] codec:video_blackout_policy_store(0) [13025.638825@3] [tsync_avevent]event:1, param 1 [13025.638831@3] video pause! [13025.639019@3] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [13025.639117@2] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [13025.639125@2] DI: di_receiver_event_fun: vf_notify_receiver unreg [13025.639145@1] codec:keep exit is di [13025.639152@1] [tsync_avevent]event:2, param 0 [13025.639158@1] codec:video first pts = 0 [13025.639178@0] di_uninit_buf keep cur di_buf 4 (7 1 0) [13025.649519@2] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [13025.649835@2] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [13025.660419@0] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [13025.660420@0] DI: di_receiver_event_fun: vframe provider reg [13025.670577@0] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [13025.670581@0] tv_vout: vout [framerate_automation_process] duration = 3840 [13025.670584@0] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [13025.670585@0] tv_vout: fr_vsource = 2500 [13025.670594@0] tv_vout: mode_target=18,is_receiver_supported=1 [13025.671094@0] codec:video first pts = 0 [13025.672024@0] codec:video_blackout_policy_store(1) [13041.191216@1] codec:video first checkin pts = 26ae15 [13041.191222@1] codec:first check in vpts <0x94:0x26ae15> ok! [13041.191474@0] codec:Enter set parameter cmd1. [13041.193445@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [13041.193455@0] codec:actual_dpb_size 15 max_dpb_size 5 [13041.193542@0] codec:video first pts = 26ae15 [13041.508067@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [13043.518515@0] vpts to scr, apts = 0x0, vpts = 0x26ae15 [13043.518540@0] codec:[video4osd] first picture {1920,1080} pts:26bc25, [13043.538539@0] codec:VsyncEnableVideoLayer [13050.178519@0] DI: recycle_keep_buffer recycle keep cur di_buf 4 ( [13050.178531@0] DI: 7 DI: 1 [13050.178541@0] DI: 0 <7>[13050.178545@0] DI: ) [13050.261159@0] vidioc_qbuf skip: index:625902:625901 [13050.476782@0] codec:restart correct frame duration [13050.476806@0] codec:new=4608,old_duration=3840,cnt=25 [13051.716885@0] codec:restart correct frame duration [13051.716928@0] codec:new=4608,old_duration=3840,cnt=25 [13053.078875@0] codec:video_blackout_policy_store(0) [13053.080584@0] [tsync_avevent]event:1, param 1 [13053.080613@0] video pause! [13053.082286@0] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [13053.083425@3] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [13053.083447@3] DI: di_receiver_event_fun: vf_notify_receiver unreg [13053.083503@2] codec:keep exit is di [13053.083526@2] [tsync_avevent]event:2, param 0 [13053.083538@2] codec:video first pts = 0 [13053.083576@0] di_uninit_buf keep cur di_buf 1 (1 0 4) [13053.093869@3] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [13053.094249@3] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [13053.094893@3] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [13053.096681@3] DI: di_receiver_event_fun: vframe provider reg [13053.106829@3] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [13053.106842@3] tv_vout: vout [framerate_automation_process] duration = 3840 [13053.106847@3] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [13053.106852@3] tv_vout: fr_vsource = 2500 [13053.106863@3] tv_vout: mode_target=18,is_receiver_supported=1 [13053.107417@3] codec:video first pts = 0 [13053.107689@3] codec:video_blackout_policy_store(1) [13057.402467@2] codec:video first checkin pts = 3cd145 [13057.402490@2] codec:first check in vpts <0x94:0x3cd145> ok! [13057.402699@0] codec:Enter set parameter cmd1. [13057.405259@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [13057.405285@0] codec:actual_dpb_size 15 max_dpb_size 5 [13057.405384@0] codec:video first pts = 3cd145 [13057.578102@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [13059.198523@0] vpts to scr, apts = 0x0, vpts = 0x3cd145 [13059.198576@0] codec:[video4osd] first picture {1920,1080} pts:3cdf55, [13059.218536@0] codec:VsyncEnableVideoLayer [13062.058519@0] DI: recycle_keep_buffer recycle keep cur di_buf 1 ( [13062.058531@0] DI: 1 DI: 0 [13062.058541@0] DI: 4 <7>[13062.058546@0] DI: ) [13062.100039@3] vidioc_qbuf skip: index:626000:625999 [13062.316262@0] codec:finished correct frame dur [13062.316277@0] codec: new=3840,old_duration=3840,cnt=25 [14697.678841@1] codec:video_blackout_policy_store(0) [14697.678930@1] [tsync_avevent]event:1, param 1 [14697.678942@1] video pause! [14697.679368@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [14697.679503@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [14697.679516@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [14697.679545@2] codec:keep exit is di [14697.679559@2] [tsync_avevent]event:2, param 0 [14697.679663@2] codec:video first pts = 0 [14697.679702@0] di_uninit_buf keep cur di_buf 4 (9 8 3) [14697.689928@1] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [14697.690264@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [14697.695588@3] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [14697.695588@3] DI: di_receiver_event_fun: vframe provider reg [14697.705704@3] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [14697.705708@3] tv_vout: vout [framerate_automation_process] duration = 3840 [14697.705711@3] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [14697.705712@3] tv_vout: fr_vsource = 2500 [14697.705721@3] tv_vout: mode_target=18,is_receiver_supported=1 [14697.707458@3] codec:video first pts = 0 [14697.708378@3] codec:video_blackout_policy_store(1) [14706.777893@0] codec:video first checkin pts = 915de65 [14706.777899@0] codec:first check in vpts <0x94:0x915de65> ok! [14706.778285@0] codec:Enter set parameter cmd1. [14706.779695@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [14706.779720@0] codec:actual_dpb_size 15 max_dpb_size 5 [14706.779814@0] codec:video first pts = 915de65 [14706.945842@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [14708.678450@0] vpts to scr, apts = 0x0, vpts = 0x915de65 [14708.678475@0] codec:[video4osd] first picture {1920,1080} pts:915ec75, [14708.698472@0] codec:VsyncEnableVideoLayer [14710.938470@0] DI: recycle_keep_buffer recycle keep cur di_buf 4 ( [14710.938491@0] DI: 9 DI: 8 [14710.938508@0] DI: 3 <7>[14710.938517@0] DI: ) [14710.980426@1] vidioc_qbuf skip: index:707718:707717 [14711.234674@0] codec:finished correct frame dur [14711.234691@0] codec: new=3840,old_duration=3840,cnt=25 [15992.564540@0] vidioc_qbuf skip: index:771739:771737 [15992.564627@0] vidioc_qbuf skip: index:771739:771738 [16235.098515@1] codec:video_blackout_policy_store(0) [16235.099540@1] [tsync_avevent]event:1, param 1 [16235.099543@1] video pause! [16235.100144@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [16235.100265@2] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [16235.100270@2] DI: di_receiver_event_fun: vf_notify_receiver unreg [16235.100365@1] codec:keep exit is di [16235.100371@1] [tsync_avevent]event:2, param 0 [16235.100376@1] codec:video first pts = 0 [16235.100394@0] di_uninit_buf keep cur di_buf 9 (8 3 4) [16235.110631@2] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [16235.111689@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [16235.114512@1] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [16235.114513@1] DI: di_receiver_event_fun: vframe provider reg [16235.124606@1] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [16235.124608@1] tv_vout: vout [framerate_automation_process] duration = 3840 [16235.124610@1] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [16235.124611@1] tv_vout: fr_vsource = 2500 [16235.124619@1] tv_vout: mode_target=18,is_receiver_supported=1 [16235.125021@1] codec:video first pts = 0 [16235.125201@1] codec:video_blackout_policy_store(1) [16247.021066@0] codec:video first checkin pts = 1158d8c5 [16247.021096@0] codec:first check in vpts <0x94:0x1158d8c5> ok! [16247.021375@0] codec:Enter set parameter cmd1. [16247.022873@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [16247.022902@0] codec:actual_dpb_size 15 max_dpb_size 5 [16247.023003@0] codec:video first pts = 1158d8c5 [16247.331174@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [16248.818390@0] vpts to scr, apts = 0x0, vpts = 0x1158d8c5 [16248.818416@0] codec:[video4osd] first picture {1920,1080} pts:1158e6d5, [16248.838402@0] codec:VsyncEnableVideoLayer [16251.118398@0] DI: recycle_keep_buffer recycle keep cur di_buf 9 ( [16251.118400@0] DI: 8 [16251.118403@0] DI: 3 [16251.118405@0] DI: 4 [16251.118405@0] DI: ) [16251.167231@1] vidioc_qbuf skip: index:783829:783828 [16251.419159@0] codec:finished correct frame dur [16251.419183@0] codec: new=3840,old_duration=3840,cnt=25 [17383.701280@3] codec:video_blackout_policy_store(0) [17383.701449@3] [tsync_avevent]event:1, param 1 [17383.701470@3] video pause! [17383.702208@3] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [17383.702436@3] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [17383.702462@3] DI: di_receiver_event_fun: vf_notify_receiver unreg [17383.702542@3] codec:keep exit is di [17383.702564@3] [tsync_avevent]event:2, param 0 [17383.702584@3] codec:video first pts = 0 [17383.702661@0] di_uninit_buf keep cur di_buf 6 (7 1 0) [17383.713480@3] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [17383.718000@3] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [17383.719350@3] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [17383.728402@3] DI: di_receiver_event_fun: vframe provider reg [17383.738537@3] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [17383.738549@3] tv_vout: vout [framerate_automation_process] duration = 3840 [17383.738555@3] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [17383.738560@3] tv_vout: fr_vsource = 2500 [17383.738571@3] tv_vout: mode_target=18,is_receiver_supported=1 [17383.739046@3] codec:video first pts = 0 [17383.739255@3] codec:video_blackout_policy_store(1) [17397.562988@0] codec:video first checkin pts = 1784e685 [17397.563003@0] codec:first check in vpts <0x94:0x1784e685> ok! [17397.563148@0] codec:Enter set parameter cmd1. [17397.565737@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [17397.565747@0] codec:actual_dpb_size 15 max_dpb_size 5 [17397.565800@0] codec:video first pts = 1784e685 [17397.807654@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [17399.438340@0] vpts to scr, apts = 0x0, vpts = 0x1784e685 [17399.438374@0] codec:[video4osd] first picture {1920,1080} pts:1784f495, [17399.458363@0] codec:VsyncEnableVideoLayer [17402.378346@0] DI: recycle_keep_buffer recycle keep cur di_buf 6 ( [17402.378359@0] DI: 7 DI: 1 [17402.378369@0] DI: 0 <7>[17402.378374@0] DI: ) [17402.419943@0] vidioc_qbuf skip: index:840335:840334 [17402.674467@0] codec:finished correct frame dur [17402.674483@0] codec: new=3840,old_duration=3840,cnt=25 [20135.723926@0] codec:video_blackout_policy_store(0) [20135.724099@0] [tsync_avevent]event:1, param 1 [20135.724120@0] video pause! [20135.724894@0] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [20135.728084@0] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [20135.728124@0] DI: di_receiver_event_fun: vf_notify_receiver unreg [20135.728401@1] codec:keep exit is di [20135.728432@1] [tsync_avevent]event:2, param 0 [20135.728454@1] codec:video first pts = 0 [20135.728529@0] di_uninit_buf keep cur di_buf 10 (5 6 9) [20135.738652@0] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [20135.738996@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [20135.739664@1] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [20135.741436@1] DI: di_receiver_event_fun: vframe provider reg [20135.751588@1] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [20135.751599@1] tv_vout: vout [framerate_automation_process] duration = 3840 [20135.751605@1] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [20135.751609@1] tv_vout: fr_vsource = 2500 [20135.751620@1] tv_vout: mode_target=18,is_receiver_supported=1 [20135.752137@1] codec:video first pts = 0 [20135.752418@1] codec:video_blackout_policy_store(1) [20147.846353@0] codec:video first checkin pts = 2645d5d5 [20147.846377@0] codec:first check in vpts <0x94:0x2645d5d5> ok! [20147.846570@0] codec:Enter set parameter cmd1. [20147.847689@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [20147.847706@0] codec:actual_dpb_size 15 max_dpb_size 5 [20147.847789@0] codec:video first pts = 2645d5d5 [20148.122360@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [20149.558230@0] vpts to scr, apts = 0x0, vpts = 0x2645d5d5 [20149.558261@0] codec:[video4osd] first picture {1920,1080} pts:2645e3e5, [20149.578250@0] codec:VsyncEnableVideoLayer [20152.818254@0] DI: recycle_keep_buffer recycle keep cur di_buf 10 ( [20152.818274@0] DI: 5 DI: 6 [20152.818291@0] DI: 9 <7>[20152.818300@0] DI: ) [20152.860659@2] vidioc_qbuf skip: index:976668:976667 [20153.121285@0] codec:finished correct frame dur [20153.121301@0] codec: new=3840,old_duration=3840,cnt=25 [20170.078398@3] codec:video_blackout_policy_store(0) [20170.079563@3] [tsync_avevent]event:1, param 1 [20170.079573@3] video pause! [20170.080203@3] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [20170.080307@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [20170.080312@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [20170.080338@1] codec:keep exit is di [20170.080342@1] [tsync_avevent]event:2, param 0 [20170.080347@1] codec:video first pts = 0 [20170.080363@0] di_uninit_buf keep cur di_buf 11 (7 1 0) [20170.090683@1] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [20170.091048@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [20170.092191@2] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [20170.093224@2] DI: di_receiver_event_fun: vframe provider reg [20170.103364@2] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [20170.103376@2] tv_vout: vout [framerate_automation_process] duration = 3840 [20170.103380@2] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [20170.103383@2] tv_vout: fr_vsource = 2500 [20170.103392@2] tv_vout: mode_target=18,is_receiver_supported=1 [20170.103952@2] codec:video first pts = 0 [20170.104147@2] codec:video_blackout_policy_store(1) [20177.457074@0] codec:video first checkin pts = 266de165 [20177.457087@0] codec:first check in vpts <0x94:0x266de165> ok! [20177.457232@0] codec:Enter set parameter cmd1. [20177.459625@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [20177.459649@0] codec:actual_dpb_size 15 max_dpb_size 5 [20177.459714@0] codec:video first pts = 266de165 [20177.512313@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [20178.798228@0] vpts to scr, apts = 0x0, vpts = 0x266de165 [20178.798263@0] codec:[video4osd] first picture {1920,1080} pts:266def75, [20178.818257@0] codec:VsyncEnableVideoLayer [20181.158236@0] DI: recycle_keep_buffer recycle keep cur di_buf 11 ( [20181.158249@0] DI: 7 DI: 1 [20181.158258@0] DI: 0 <7>[20181.158265@0] DI: queue_in:di_buf_post[11] Error, queue_index(6) is not -1 [20181.158269@0] DI: ) [20181.162242@1] DI: ====== DI force recovery ========= [20181.162271@1] di_uninit_buf keep cur di_buf 4 (6 8 9) [20181.172290@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [20181.178233@0] DI: recycle_keep_buffer recycle keep cur di_buf 4 ( [20181.178246@0] DI: 6 DI: 8 [20181.178255@0] DI: 9 <7>[20181.178259@0] DI: ) [20181.178301@0] de_post_process post_buf[5] is in post free list. [20181.198270@0] de_post_process post_buf[5] is in post free list. [20181.459464@0] codec:finished correct frame dur [20181.459481@0] codec: new=3840,old_duration=3840,cnt=25 [22756.265414@3] codec:video_blackout_policy_store(0) [22756.265592@3] [tsync_avevent]event:1, param 1 [22756.265613@3] video pause! [22756.266335@3] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [22756.273316@3] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [22756.273358@3] DI: di_receiver_event_fun: vf_notify_receiver unreg [22756.273453@3] codec:keep exit is di [22756.273476@3] [tsync_avevent]event:2, param 0 [22756.273497@3] codec:video first pts = 0 [22756.273567@0] di_uninit_buf keep cur di_buf 10 (9 1 0) [22756.283796@3] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [22756.284144@3] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [22756.285565@3] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [22756.295532@3] DI: di_receiver_event_fun: vframe provider reg [22756.305676@3] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [22756.305691@3] tv_vout: vout [framerate_automation_process] duration = 3840 [22756.305697@3] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [22756.305702@3] tv_vout: fr_vsource = 2500 [22756.305713@3] tv_vout: mode_target=18,is_receiver_supported=1 [22756.306233@3] codec:video first pts = 0 [22756.306443@3] codec:video_blackout_policy_store(1) [22767.604011@3] codec:video first checkin pts = 34535d05 [22767.604025@3] codec:first check in vpts <0x94:0x34535d05> ok! [22767.604181@0] codec:Enter set parameter cmd1. [22767.605267@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [22767.605280@0] codec:actual_dpb_size 15 max_dpb_size 5 [22767.605346@0] codec:video first pts = 34535d05 [22767.755142@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [22769.318125@0] vpts to scr, apts = 0x0, vpts = 0x34535d05 [22769.318161@0] codec:[video4osd] first picture {1920,1080} pts:34536b15, [22769.338150@0] codec:VsyncEnableVideoLayer [22772.238134@0] DI: recycle_keep_buffer recycle keep cur di_buf 10 ( [22772.238145@0] DI: 9 DI: 1 [22772.238157@0] DI: 0 <7>[22772.238161@0] DI: ) [22772.280478@2] vidioc_qbuf skip: index:1105938:1105937 [22772.493697@0] codec:finished correct frame dur [22772.493713@0] codec: new=3840,old_duration=3840,cnt=25 [25684.938868@2] codec:video_blackout_policy_store(0) [25684.939531@1] [tsync_avevent]event:1, param 1 [25684.939541@1] video pause! [25684.939768@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [25684.939840@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [25684.939847@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [25684.939866@3] codec:keep exit is di [25684.939874@3] [tsync_avevent]event:2, param 0 [25684.939880@3] codec:video first pts = 0 [25684.939902@0] di_uninit_buf keep cur di_buf 5 (7 3 2) [25684.950256@1] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [25684.950616@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [25684.951857@1] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [25684.960047@1] DI: di_receiver_event_fun: vframe provider reg [25684.970173@1] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [25684.970184@1] tv_vout: vout [framerate_automation_process] duration = 3840 [25684.970189@1] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [25684.970192@1] tv_vout: fr_vsource = 2500 [25684.970202@1] tv_vout: mode_target=18,is_receiver_supported=1 [25684.970742@1] codec:video first pts = 0 [25684.970958@1] codec:video_blackout_policy_store(1) [25696.898716@2] codec:video_blackout_policy_store(0) [25696.898818@2] [tsync_avevent]event:1, param 1 [25696.898828@2] video pause! [25696.899346@2] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [25696.899626@2] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [25696.899652@2] DI: di_receiver_event_fun: vf_notify_receiver unreg [25696.899685@3] codec:keep exit is di [25696.899701@3] [tsync_avevent]event:2, param 0 [25696.899712@3] codec:video first pts = 0 [25696.899772@0] di_uninit_buf keep cur di_buf 5 (7 3 2) [25696.911151@0] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [25696.913442@0] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [25696.913442@0] DI: di_receiver_event_fun: vframe provider reg [25696.923579@0] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [25696.923583@0] tv_vout: vout [framerate_automation_process] duration = 3840 [25696.923586@0] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [25696.923587@0] tv_vout: fr_vsource = 2500 [25696.923596@0] tv_vout: mode_target=18,is_receiver_supported=1 [25696.924119@0] codec:video first pts = 0 [25696.924311@0] codec:video_blackout_policy_store(1) [25697.002209@1] codec:video first checkin pts = 440a7265 [25697.002212@1] codec:first check in vpts <0x94:0x440a7265> ok! [25697.002392@0] codec:Enter set parameter cmd1. [25697.003848@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [25697.003855@0] codec:actual_dpb_size 15 max_dpb_size 5 [25697.003908@0] codec:video first pts = 440a7265 [25697.309623@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [25698.838012@0] vpts to scr, apts = 0x0, vpts = 0x440a7265 [25698.838046@0] codec:[video4osd] first picture {1920,1080} pts:440a8075, [25698.858034@0] codec:VsyncEnableVideoLayer [25701.198031@0] DI: recycle_keep_buffer recycle keep cur di_buf 5 ( [25701.198053@0] DI: 7 DI: 3 [25701.198070@0] DI: 2 <7>[25701.198079@0] DI: ) [25701.241417@0] vidioc_qbuf skip: index:1251243:1251242 [25701.498147@0] codec:finished correct frame dur [25701.498159@0] codec: new=3840,old_duration=3840,cnt=25 [26105.178692@2] codec:video_blackout_policy_store(0) [26105.178915@2] [tsync_avevent]event:1, param 1 [26105.178937@2] video pause! [26105.180038@2] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [26105.180495@2] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [26105.180523@2] DI: di_receiver_event_fun: vf_notify_receiver unreg [26105.180897@2] codec:keep exit is di [26105.180924@2] [tsync_avevent]event:2, param 0 [26105.180946@2] codec:video first pts = 0 [26105.181038@0] di_uninit_buf keep cur di_buf 11 (0 7 3) [26105.191009@2] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [26105.192507@2] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [26105.194558@2] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [26105.196358@2] DI: di_receiver_event_fun: vframe provider reg [26105.206543@2] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [26105.206556@2] tv_vout: vout [framerate_automation_process] duration = 3840 [26105.206563@2] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [26105.206567@2] tv_vout: fr_vsource = 2500 [26105.206579@2] tv_vout: mode_target=18,is_receiver_supported=1 [26105.207166@2] codec:video first pts = 0 [26105.208169@2] codec:video_blackout_policy_store(1) [26117.332446@1] codec:video first checkin pts = 464bab25 [26117.332460@1] codec:first check in vpts <0x94:0x464bab25> ok! [26117.332610@0] codec:Enter set parameter cmd1. [26117.333668@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [26117.333679@0] codec:actual_dpb_size 15 max_dpb_size 5 [26117.333739@0] codec:video first pts = 464bab25 [26117.440493@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [26119.097993@0] vpts to scr, apts = 0x0, vpts = 0x464bab25 [26119.098026@0] codec:[video4osd] first picture {1920,1080} pts:464bb935, [26119.118014@0] codec:VsyncEnableVideoLayer [26121.838012@0] DI: recycle_keep_buffer recycle keep cur di_buf 11 ( [26121.838030@0] DI: 0 DI: 7 [26121.838047@0] DI: 3 <7>[26121.838056@0] DI: ) [26121.881198@0] vidioc_qbuf skip: index:1271396:1271395 [26122.139047@0] codec:finished correct frame dur [26122.139065@0] codec: new=3840,old_duration=3840,cnt=25 [27088.680328@2] vidioc_qbuf skip: index:1319626:1319625 [28044.119730@1] codec:video_blackout_policy_store(0) [28044.119797@1] [tsync_avevent]event:1, param 1 [28044.119803@1] video pause! [28044.120029@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [28044.120107@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [28044.120116@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [28044.120149@1] codec:keep exit is di [28044.120156@1] [tsync_avevent]event:2, param 0 [28044.120161@1] codec:video first pts = 0 [28044.120183@0] di_uninit_buf keep cur di_buf 1 (7 3 4) [28044.130539@1] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [28044.130909@0] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [28044.131667@2] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [28044.139968@2] DI: di_receiver_event_fun: vframe provider reg [28044.150113@2] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [28044.150135@2] tv_vout: vout [framerate_automation_process] duration = 3840 [28044.150141@2] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [28044.150145@2] tv_vout: fr_vsource = 2500 [28044.150157@2] tv_vout: mode_target=18,is_receiver_supported=1 [28044.150726@2] codec:video first pts = 0 [28044.150952@2] codec:video_blackout_policy_store(1) [28057.924473@2] codec:video first checkin pts = 50b49135 [28057.924475@2] codec:first check in vpts <0x94:0x50b49135> ok! [28057.924720@0] codec:Enter set parameter cmd1. [28057.925769@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [28057.925775@0] codec:actual_dpb_size 15 max_dpb_size 5 [28057.925822@0] codec:video first pts = 50b49135 [28058.088444@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [28059.777913@0] vpts to scr, apts = 0x0, vpts = 0x50b49135 [28059.777947@0] codec:[video4osd] first picture {1920,1080} pts:50b49f45, [28059.797938@0] codec:VsyncEnableVideoLayer [28063.117920@0] DI: recycle_keep_buffer recycle keep cur di_buf 1 ( [28063.117934@0] DI: 7 DI: 3 [28063.117943@0] DI: 4 <7>[28063.117948@0] DI: ) [28063.159392@1] vidioc_qbuf skip: index:1367254:1367253 [28063.416130@0] codec:finished correct frame dur [28063.416155@0] codec: new=3840,old_duration=3840,cnt=25 [28578.458945@1] codec:video_blackout_policy_store(0) [28578.459122@1] [tsync_avevent]event:1, param 1 [28578.459144@1] video pause! [28578.459697@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [28578.460013@2] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [28578.460042@2] DI: di_receiver_event_fun: vf_notify_receiver unreg [28578.460130@2] codec:keep exit is di [28578.460317@2] [tsync_avevent]event:2, param 0 [28578.460354@2] codec:video first pts = 0 [28578.460426@0] di_uninit_buf keep cur di_buf 5 (3 4 2) [28578.470619@2] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [28578.471764@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [28578.472739@1] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [28578.474347@1] DI: di_receiver_event_fun: vframe provider reg [28578.484529@1] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [28578.484541@1] tv_vout: vout [framerate_automation_process] duration = 3840 [28578.484547@1] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [28578.484551@1] tv_vout: fr_vsource = 2500 [28578.484563@1] tv_vout: mode_target=18,is_receiver_supported=1 [28578.485063@1] codec:video first pts = 0 [28578.485375@1] codec:video_blackout_policy_store(1) [28586.694432@0] codec:video first checkin pts = 538aeda5 [28586.694447@0] codec:first check in vpts <0x94:0x538aeda5> ok! [28586.694766@0] codec:Enter set parameter cmd1. [28586.695837@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [28586.695849@0] codec:actual_dpb_size 15 max_dpb_size 5 [28586.695906@0] codec:video first pts = 538aeda5 [28587.150221@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [28588.637895@0] vpts to scr, apts = 0x0, vpts = 0x538aeda5 [28588.637931@0] codec:[video4osd] first picture {1920,1080} pts:538afbb5, [28588.657917@0] codec:VsyncEnableVideoLayer [28590.837900@0] DI: recycle_keep_buffer recycle keep cur di_buf 5 ( [28590.837912@0] DI: 3 DI: 4 [28590.837923@0] DI: 2 <7>[28590.837927@0] DI: ) [28590.881682@3] vidioc_qbuf skip: index:1392964:1392963 [28591.139495@0] codec:finished correct frame dur [28591.139512@0] codec: new=3840,old_duration=3840,cnt=25 [29225.298610@3] codec:video_blackout_policy_store(0) [29225.298678@3] [tsync_avevent]event:1, param 1 [29225.298684@3] video pause! [29225.298920@3] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [29225.299003@3] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [29225.299010@3] DI: di_receiver_event_fun: vf_notify_receiver unreg [29225.299048@3] codec:keep exit is di [29225.299055@3] [tsync_avevent]event:2, param 0 [29225.299061@3] codec:video first pts = 0 [29225.299084@0] di_uninit_buf keep cur di_buf 11 (1 0 3) [29225.309413@3] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [29225.309768@3] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [29225.311212@3] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [29225.318009@3] DI: di_receiver_event_fun: vframe provider reg [29225.328152@3] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [29225.328164@3] tv_vout: vout [framerate_automation_process] duration = 3840 [29225.328170@3] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [29225.328175@3] tv_vout: fr_vsource = 2500 [29225.328187@3] tv_vout: mode_target=18,is_receiver_supported=1 [29225.328706@3] codec:video first pts = 0 [29225.329597@3] codec:video_blackout_policy_store(1) [29237.240256@3] codec:video first checkin pts = 57078335 [29237.240268@3] codec:first check in vpts <0x94:0x57078335> ok! [29237.240498@0] codec:Enter set parameter cmd1. [29237.241578@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [29237.241594@0] codec:actual_dpb_size 15 max_dpb_size 5 [29237.241657@0] codec:video first pts = 57078335 [29237.307738@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [29238.737869@0] vpts to scr, apts = 0x0, vpts = 0x57078335 [29238.737904@0] codec:[video4osd] first picture {1920,1080} pts:57079145, [29238.757890@0] codec:VsyncEnableVideoLayer [29240.917871@0] DI: recycle_keep_buffer recycle keep cur di_buf 11 ( [29240.917883@0] DI: 1 DI: 0 [29240.917894@0] DI: 3 <7>[29240.917898@0] DI: ) [29240.959633@0] vidioc_qbuf skip: index:1424610:1424609 [29241.216977@0] codec:finished correct frame dur [29241.216992@0] codec: new=3840,old_duration=3840,cnt=25 [29546.118396@0] codec:video_blackout_policy_store(0) [29546.118460@0] [tsync_avevent]event:1, param 1 [29546.118466@0] video pause! [29546.118703@0] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [29546.119119@0] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [29546.119129@0] DI: di_receiver_event_fun: vf_notify_receiver unreg [29546.119186@0] codec:keep exit is di [29546.119193@0] [tsync_avevent]event:2, param 0 [29546.119199@0] codec:video first pts = 0 [29546.119232@0] di_uninit_buf keep cur di_buf 13 (5 6 7) [29546.129551@0] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [29546.129900@0] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [29546.131527@0] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [29546.133219@0] DI: di_receiver_event_fun: vframe provider reg [29546.143352@0] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [29546.143363@0] tv_vout: vout [framerate_automation_process] duration = 3840 [29546.143370@0] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [29546.143374@0] tv_vout: fr_vsource = 2500 [29546.143386@0] tv_vout: mode_target=18,is_receiver_supported=1 [29546.143890@0] codec:video first pts = 0 [29546.144150@0] codec:video_blackout_policy_store(1) [29557.082523@2] codec:video first checkin pts = 58bf83d5 [29557.082545@2] codec:first check in vpts <0x94:0x58bf83d5> ok! [29557.082875@0] codec:Enter set parameter cmd1. [29557.084106@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [29557.084116@0] codec:actual_dpb_size 15 max_dpb_size 5 [29557.084198@0] codec:video first pts = 58bf83d5 [29557.372674@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [29558.937867@0] vpts to scr, apts = 0x0, vpts = 0x58bf83d5 [29558.937921@0] codec:[video4osd] first picture {1920,1080} pts:58bf91e5, [29558.957884@0] codec:VsyncEnableVideoLayer [29561.537861@0] DI: recycle_keep_buffer recycle keep cur di_buf 13 ( [29561.537873@0] DI: 5 DI: 6 [29561.537883@0] DI: 7 <7>[29561.537887@0] DI: ) [29561.580183@0] vidioc_qbuf skip: index:1439838:1439837 [29561.801222@0] codec:finished correct frame dur [29561.801239@0] codec: new=3840,old_duration=3840,cnt=25 [30627.619784@1] codec:video_blackout_policy_store(0) [30627.619956@1] [tsync_avevent]event:1, param 1 [30627.619977@1] video pause! [30627.620755@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [30627.621048@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [30627.621075@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [30627.621157@1] codec:keep exit is di [30627.621182@1] [tsync_avevent]event:2, param 0 [30627.621203@1] codec:video first pts = 0 [30627.621275@0] di_uninit_buf keep cur di_buf 14 (5 6 7) [30627.631806@1] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [30627.632365@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [30627.633487@2] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [30627.641820@2] DI: di_receiver_event_fun: vframe provider reg [30627.652023@2] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [30627.652035@2] tv_vout: vout [framerate_automation_process] duration = 3840 [30627.652041@2] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [30627.652046@2] tv_vout: fr_vsource = 2500 [30627.652057@2] tv_vout: mode_target=18,is_receiver_supported=1 [30627.652600@2] codec:video first pts = 0 [30627.652829@2] codec:video_blackout_policy_store(1) [30637.917706@0] codec:video first checkin pts = 5e8bc495 [30637.917712@0] codec:first check in vpts <0x94:0x5e8bc495> ok! [30637.918052@0] codec:Enter set parameter cmd1. [30637.919213@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [30637.919235@0] codec:actual_dpb_size 15 max_dpb_size 5 [30637.919332@0] codec:video first pts = 5e8bc495 [30638.019075@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [30639.777821@0] vpts to scr, apts = 0x0, vpts = 0x5e8bc495 [30639.777876@0] codec:[video4osd] first picture {1920,1080} pts:5e8bd2a5, [30639.797859@0] codec:VsyncEnableVideoLayer [30643.117820@0] DI: recycle_keep_buffer recycle keep cur di_buf 14 ( [30643.117831@0] DI: 5 DI: 6 [30643.117841@0] DI: 7 <7>[30643.117845@0] DI: ) [30643.159748@3] vidioc_qbuf skip: index:1493003:1493002 [30643.417802@0] codec:finished correct frame dur [30643.417826@0] codec: new=3840,old_duration=3840,cnt=25 [31845.521178@0] codec:video_blackout_policy_store(0) [31845.521345@0] [tsync_avevent]event:1, param 1 [31845.521366@0] video pause! [31845.522114@0] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [31845.522318@0] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [31845.522347@0] DI: di_receiver_event_fun: vf_notify_receiver unreg [31845.522442@2] codec:keep exit is di [31845.522470@2] [tsync_avevent]event:2, param 0 [31845.522492@2] codec:video first pts = 0 [31845.522564@0] di_uninit_buf keep cur di_buf 8 (2 3 4) [31845.533411@0] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [31845.533925@0] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [31845.536075@0] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [31845.538530@0] DI: di_receiver_event_fun: vframe provider reg [31845.548707@0] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [31845.548720@0] tv_vout: vout [framerate_automation_process] duration = 3840 [31845.548726@0] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [31845.548731@0] tv_vout: fr_vsource = 2500 [31845.548743@0] tv_vout: mode_target=18,is_receiver_supported=1 [31845.549273@0] codec:video first pts = 0 [31845.549496@0] codec:video_blackout_policy_store(1) [31857.052805@1] codec:video first checkin pts = 6515cf45 [31857.052819@1] codec:first check in vpts <0x94:0x6515cf45> ok! [31857.053151@0] codec:Enter set parameter cmd1. [31857.054391@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [31857.054402@0] codec:actual_dpb_size 15 max_dpb_size 5 [31857.054465@0] codec:video first pts = 6515cf45 [31857.232759@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [31858.917776@0] vpts to scr, apts = 0x0, vpts = 0x6515cf45 [31858.917831@0] codec:[video4osd] first picture {1920,1080} pts:6515dd55, [31858.937784@0] codec:VsyncEnableVideoLayer [31861.277765@0] DI: recycle_keep_buffer recycle keep cur di_buf 8 ( [31861.277778@0] DI: 2 DI: 3 [31861.277787@0] DI: 4 <7>[31861.277792@0] DI: ) [31861.320039@3] vidioc_qbuf skip: index:1552996:1552995 [31861.582980@0] codec:finished correct frame dur [31861.583006@0] codec: new=3840,old_duration=3840,cnt=25 [32446.598436@2] codec:video_blackout_policy_store(0) [32446.603198@1] [tsync_avevent]event:1, param 1 [32446.603209@1] video pause! [32446.603516@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [32446.603613@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [32446.603621@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [32446.603652@1] codec:keep exit is di [32446.603659@1] [tsync_avevent]event:2, param 0 [32446.603665@1] codec:video first pts = 0 [32446.603687@0] di_uninit_buf keep cur di_buf 10 (4 5 6) [32446.614039@1] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [32446.614417@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [32446.615156@1] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [32446.616887@1] DI: di_receiver_event_fun: vframe provider reg [32446.627024@1] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [32446.627036@1] tv_vout: vout [framerate_automation_process] duration = 3840 [32446.627043@1] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [32446.627048@1] tv_vout: fr_vsource = 2500 [32446.627060@1] tv_vout: mode_target=18,is_receiver_supported=1 [32446.627547@1] codec:video first pts = 0 [32446.627824@1] codec:video_blackout_policy_store(1) [32458.097301@0] codec:video first checkin pts = 684efe25 [32458.097316@0] codec:first check in vpts <0x94:0x684efe25> ok! [32458.097583@0] codec:Enter set parameter cmd1. [32458.098648@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [32458.098662@0] codec:actual_dpb_size 15 max_dpb_size 5 [32458.098725@0] codec:video first pts = 684efe25 [32458.342339@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [32459.737748@0] vpts to scr, apts = 0x0, vpts = 0x684efe25 [32459.737801@0] codec:[video4osd] first picture {1920,1080} pts:684f0c35, [32459.757786@0] codec:VsyncEnableVideoLayer [32463.077741@0] DI: recycle_keep_buffer recycle keep cur di_buf 10 ( [32463.077753@0] DI: 4 DI: 5 [32463.077764@0] DI: 6 <7>[32463.077768@0] DI: ) [32463.120045@0] vidioc_qbuf skip: index:1582174:1582173 [32463.381919@0] codec:finished correct frame dur [32463.381943@0] codec: new=3840,old_duration=3840,cnt=25 [32750.359207@2] codec:video_blackout_policy_store(0) [32750.359377@2] [tsync_avevent]event:1, param 1 [32750.359506@2] video pause! [32750.360451@2] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [32750.360817@2] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [32750.360843@2] DI: di_receiver_event_fun: vf_notify_receiver unreg [32750.360929@2] codec:keep exit is di [32750.360951@2] [tsync_avevent]event:2, param 0 [32750.360971@2] codec:video first pts = 0 [32750.361037@0] di_uninit_buf keep cur di_buf 9 (3 7 9) [32750.371286@2] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [32750.373489@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [32750.383262@1] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [32750.384842@1] DI: di_receiver_event_fun: vframe provider reg [32750.394952@1] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [32750.394963@1] tv_vout: vout [framerate_automation_process] duration = 3840 [32750.394967@1] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [32750.394971@1] tv_vout: fr_vsource = 2500 [32750.394980@1] tv_vout: mode_target=18,is_receiver_supported=1 [32750.395476@1] codec:video first pts = 0 [32750.395678@1] codec:video_blackout_policy_store(1) [32757.575855@0] codec:video first checkin pts = 69ea27f5 [32757.575868@0] codec:first check in vpts <0x94:0x69ea27f5> ok! [32757.576026@0] codec:Enter set parameter cmd1. [32757.578233@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [32757.578249@0] codec:actual_dpb_size 15 max_dpb_size 5 [32757.578317@0] codec:video first pts = 69ea27f5 [32757.682856@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [32759.217726@0] vpts to scr, apts = 0x0, vpts = 0x69ea27f5 [32759.217749@0] codec:[video4osd] first picture {1920,1080} pts:69ea3605, [32759.237744@0] codec:VsyncEnableVideoLayer [32761.657731@0] DI: recycle_keep_buffer recycle keep cur di_buf 9 ( [32761.657745@0] DI: 3 DI: 7 [32761.657755@0] DI: 9 <7>[32761.657760@0] DI: ) [32761.699868@0] vidioc_qbuf skip: index:1596495:1596494 [32761.963143@0] codec:restart correct frame duration [32761.963158@0] codec:new=3993,old_duration=3840,cnt=25 [32763.042638@0] codec:restart correct frame duration [32763.042657@0] codec:new=3993,old_duration=3840,cnt=25 [32764.043428@0] codec:finished correct frame dur [32764.043447@0] codec: new=3840,old_duration=3840,cnt=25 [34335.638197@1] codec:video_blackout_policy_store(0) [34335.638357@1] [tsync_avevent]event:1, param 1 [34335.638377@1] video pause! [34335.639107@1] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [34335.639379@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [34335.639406@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [34335.639485@1] codec:keep exit is di [34335.639508@1] [tsync_avevent]event:2, param 0 [34335.639528@1] codec:video first pts = 0 [34335.639589@0] di_uninit_buf keep cur di_buf 5 (0 3 7) [34335.649900@1] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [34335.650249@0] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [34335.661071@0] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [34335.663400@0] DI: di_receiver_event_fun: vframe provider reg [34335.673562@0] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [34335.673574@0] tv_vout: vout [framerate_automation_process] duration = 3840 [34335.673580@0] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [34335.673585@0] tv_vout: fr_vsource = 2500 [34335.673596@0] tv_vout: mode_target=18,is_receiver_supported=1 [34335.674096@0] codec:video first pts = 0 [34335.674375@0] codec:video_blackout_policy_store(1) [34347.539087@2] codec:video first checkin pts = 7271da85 [34347.539110@2] codec:first check in vpts <0x94:0x7271da85> ok! [34347.539552@0] codec:Enter set parameter cmd1. [34347.541752@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [34347.541788@0] codec:actual_dpb_size 15 max_dpb_size 5 [34347.541875@0] codec:video first pts = 7271da85 [34347.741017@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [34349.717660@0] vpts to scr, apts = 0x0, vpts = 0x7271da85 [34349.717692@0] codec:[video4osd] first picture {1920,1080} pts:7271e895, [34349.737685@0] codec:VsyncEnableVideoLayer [34352.537667@0] DI: recycle_keep_buffer recycle keep cur di_buf 5 ( [34352.537680@0] DI: 0 DI: 3 [34352.537690@0] DI: 7 <7>[34352.537694@0] DI: ) [34352.579297@0] vidioc_qbuf skip: index:1675012:1675011 [34352.837870@0] codec:finished correct frame dur [34352.837884@0] codec: new=3840,old_duration=3840,cnt=25 [34807.618232@0] codec:video_blackout_policy_store(0) [34807.618337@0] [tsync_avevent]event:1, param 1 [34807.618348@0] video pause! [34807.618812@0] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [34807.619009@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [34807.619026@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [34807.632481@1] codec:keep exit is di [34807.632499@1] [tsync_avevent]event:2, param 0 [34807.632506@1] codec:video first pts = 0 [34807.632528@0] di_uninit_buf keep cur di_buf 4 (1 0 3) [34807.639472@1] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [34807.640689@1] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [34807.642351@1] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [34807.644101@1] DI: di_receiver_event_fun: vframe provider reg [34807.654240@1] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [34807.654251@1] tv_vout: vout [framerate_automation_process] duration = 3840 [34807.654255@1] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [34807.654259@1] tv_vout: fr_vsource = 2500 [34807.654269@1] tv_vout: mode_target=18,is_receiver_supported=1 [34807.654766@1] codec:video first pts = 0 [34807.654953@1] codec:video_blackout_policy_store(1) [34816.958379@1] codec:video first checkin pts = 74f66be5 [34816.958392@1] codec:first check in vpts <0x94:0x74f66be5> ok! [34816.958558@0] codec:Enter set parameter cmd1. [34816.959686@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [34816.959695@0] codec:actual_dpb_size 15 max_dpb_size 5 [34816.959749@0] codec:video first pts = 74f66be5 [34817.092550@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [34818.617656@0] vpts to scr, apts = 0x0, vpts = 0x74f66be5 [34818.617709@0] codec:[video4osd] first picture {1920,1080} pts:74f679f5, [34818.637694@0] codec:VsyncEnableVideoLayer [34820.777648@0] DI: recycle_keep_buffer recycle keep cur di_buf 4 ( [34820.777662@0] DI: 1 DI: 0 [34820.777673@0] DI: 3 <7>[34820.777678@0] DI: ) [34820.819708@0] vidioc_qbuf skip: index:1697723:1697722 [34821.081423@0] codec:finished correct frame dur [34821.081440@0] codec: new=3840,old_duration=3840,cnt=25 [36018.978184@0] codec:video_blackout_policy_store(0) [36018.978340@0] [tsync_avevent]event:1, param 1 [36018.978360@0] video pause! [36018.978716@0] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [36018.978818@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [36018.978826@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [36018.978851@1] codec:keep exit is di [36018.978857@1] [tsync_avevent]event:2, param 0 [36018.978864@1] codec:video first pts = 0 [36018.978885@0] di_uninit_buf keep cur di_buf 7 (8 2 1) [36018.989239@1] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [36018.989578@3] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [36018.990247@2] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [36018.991899@2] DI: di_receiver_event_fun: vframe provider reg [36019.002041@2] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [36019.002054@2] tv_vout: vout [framerate_automation_process] duration = 3840 [36019.002060@2] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [36019.002065@2] tv_vout: fr_vsource = 2500 [36019.002075@2] tv_vout: mode_target=18,is_receiver_supported=1 [36019.002699@2] codec:video first pts = 0 [36019.003703@2] codec:video_blackout_policy_store(1) [36027.608663@1] codec:video first checkin pts = 7b7533c5 [36027.608684@1] codec:first check in vpts <0x94:0x7b7533c5> ok! [36027.608875@0] codec:Enter set parameter cmd1. [36027.610908@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [36027.610927@0] codec:actual_dpb_size 15 max_dpb_size 5 [36027.611026@0] codec:video first pts = 7b7533c5 [36027.918067@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [36029.337607@0] vpts to scr, apts = 0x0, vpts = 0x7b7533c5 [36029.337661@0] codec:[video4osd] first picture {1920,1080} pts:7b7541d5, [36029.357619@0] codec:VsyncEnableVideoLayer [36032.357603@0] DI: recycle_keep_buffer recycle keep cur di_buf 7 ( [36032.357616@0] DI: 8 DI: 2 [36032.357626@0] DI: 1 <7>[36032.357631@0] DI: ) [36032.399257@1] vidioc_qbuf skip: index:1757461:1757460 [36032.657472@0] codec:finished correct frame dur [36032.657488@0] codec: new=3840,old_duration=3840,cnt=25 [36518.378743@3] codec:video_blackout_policy_store(0) [36518.378930@3] [tsync_avevent]event:1, param 1 [36518.378951@3] video pause! [36518.379740@3] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [36518.379975@3] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [36518.380001@3] DI: di_receiver_event_fun: vf_notify_receiver unreg [36518.392393@3] codec:keep exit is di [36518.392415@3] [tsync_avevent]event:2, param 0 [36518.392423@3] codec:video first pts = 0 [36518.392449@0] di_uninit_buf keep cur di_buf 15 (4 5 6) [36518.400456@3] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [36518.400843@3] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [36518.402430@2] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [36518.413597@2] DI: di_receiver_event_fun: vframe provider reg [36518.423736@2] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [36518.423749@2] tv_vout: vout [framerate_automation_process] duration = 3840 [36518.423755@2] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [36518.423760@2] tv_vout: fr_vsource = 2500 [36518.423773@2] tv_vout: mode_target=18,is_receiver_supported=1 [36518.424365@2] codec:video first pts = 0 [36518.424604@2] codec:video_blackout_policy_store(1) [36527.603907@0] codec:video first checkin pts = 7e240335 [36527.603922@0] codec:first check in vpts <0x94:0x7e240335> ok! [36527.604164@0] codec:Enter set parameter cmd1. [36527.605639@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [36527.605651@0] codec:actual_dpb_size 15 max_dpb_size 5 [36527.605712@0] codec:video first pts = 7e240335 [36527.802568@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [36529.597588@0] vpts to scr, apts = 0x0, vpts = 0x7e240335 [36529.597640@0] codec:[video4osd] first picture {1920,1080} pts:7e241145, [36529.617600@0] codec:VsyncEnableVideoLayer [36532.757580@0] DI: recycle_keep_buffer recycle keep cur di_buf 15 ( [36532.757592@0] DI: 4 DI: 5 [36532.757602@0] DI: 6 <7>[36532.757607@0] DI: ) [36532.799711@0] vidioc_qbuf skip: index:1781683:1781682 [36533.062040@0] codec:finished correct frame dur [36533.062057@0] codec: new=3840,old_duration=3840,cnt=25 [36947.179630@0] aml_snd_m8_card aml_m8_snd.45: I2S playback disable [36947.179662@0] aml_snd_m8_card aml_m8_snd.45: IEC958 playback disable [36947.179729@1] aml_spdif_dai: aml_hw_iec958_init,runtime->rate=48000, runtime->channels=2, same source mode(1) [36947.179744@1] aml_spdif_dai: share the same clock [36947.179772@1] aml_audio_hw: IEC958 PCM32 [36947.179786@1] hdmitx: audio: aout notify rate 48000 [36947.179795@1] hdmitx: audio: aout notify size 32 [36947.179804@1] hdmitx: audio: no update [36947.179819@1] aml_snd_m8_card aml_m8_snd.45: i2s/958 same source [36962.185242@2] aml_snd_card: audio speaker off [98502.927546@0] vidioc_qbuf skip: index:1798891:1798888 [98502.927638@0] vidioc_qbuf skip: index:1798891:1798889 [98502.927658@0] vidioc_qbuf skip: index:1798891:1798890 [99085.337953@3] codec:video_blackout_policy_store(0) [99088.614698@3] [tsync_avevent]event:1, param 1 [99088.614710@3] video pause! [99089.338400@2] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [99089.338501@2] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [99089.338507@2] DI: di_receiver_event_fun: vf_notify_receiver unreg [99089.338530@1] codec:keep exit is di [99089.338536@1] [tsync_avevent]event:2, param 0 [99089.338541@1] codec:video first pts = 0 [99089.338558@0] di_uninit_buf keep cur di_buf 1 (8 1 6) [99089.349461@2] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [99090.177539@0] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [99090.184392@3] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [99090.714870@3] DI: di_receiver_event_fun: vframe provider reg [99090.724995@3] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [99090.725007@3] tv_vout: vout [framerate_automation_process] duration = 3840 [99090.725012@3] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [99090.725018@3] tv_vout: fr_vsource = 2500 [99090.725029@3] tv_vout: mode_target=18,is_receiver_supported=1 [99090.725562@3] codec:video first pts = 0 [99097.013243@1] codec:video_blackout_policy_store(1) [99233.426327@3] codec:video first checkin pts = 8225 [99233.426342@3] codec:first check in vpts <0x94:0x8225> ok! [99233.642452@0] codec:Enter set parameter cmd1. [99233.643522@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [99233.643532@0] codec:actual_dpb_size 15 max_dpb_size 5 [99233.643586@0] codec:video first pts = 8225 [99384.205510@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [107061.117093@0] kodi.bin invoked oom-killer: gfp_mask=0x201da, order=0, oom_score_adj=0 [107061.117107@0] kodi.bin cpuset=/ mems_allowed=0 [107061.117115@0] CPU: 0 PID: 613 Comm: kodi.bin Tainted: P O 3.14.29 #1 [107061.117119@0] Call trace: [107061.117133@0] [] dump_backtrace+0x0/0x150 [107061.117138@0] [] show_stack+0x10/0x20 [107061.117145@0] [] dump_stack+0x78/0x94 [107061.117152@0] [] dump_header.isra.5+0x80/0x1d8 [107061.117157@0] [] oom_kill_process+0x2ec/0x430 [107061.117162@0] [] out_of_memory+0x2bc/0x2f0 [107061.117168@0] [] __alloc_pages_nodemask+0x998/0x9b0 [107061.117174@0] [] filemap_fault+0x25c/0x4a0 [107061.117181@0] [] __do_fault+0x6c/0x5e0 [107061.117186@0] [] handle_mm_fault+0x14c/0x10a0 [107061.117222@0] [] do_page_fault+0x1d0/0x258 [107061.117228@0] [] do_mem_abort+0x38/0x98 [107061.117232@0] Exception stack(0xffffffc065d67e30 to 0xffffffc065d67f50) [107061.117247@0] 7e20: 78044fa8 0000007f b54a3d90 0000007f [107061.117253@0] 7e40: ffffffff ffffffff b53b1c28 0000007f 78027c30 0000007f ffffffff ffffffff [107061.117260@0] 7e60: b564acc4 0000007f 80000000 00000000 00000020 00000000 82000007 00000000 [107061.117265@0] 7e80: b564acc4 0000007f 1c0ec298 0000007f 65d67eb0 ffffffc0 01086e10 ffffffc0 [107061.117271@0] 7ea0: 00000008 00000000 5004c02e 0000007f 197f9e80 0000007f 010842d4 ffffffc0 [107061.117277@0] 7ec0: 00000005 00000000 5004c02e 0000007f 00000005 00000000 00000005 00000000 [107061.117283@0] 7ee0: 0000006f 00000000 b53d9ba0 0000007f 00000005 00000000 00000000 00008000 [107061.117289@0] 7f00: 5004c02e 0000007f 00000005 00000000 01010101 01010101 78004c70 0000007f [107061.117294@0] 7f20: 00000000 00000000 00000020 00000000 00000000 00000000 00000000 00000000 [107061.117299@0] 7f40: 0000001a 00000000 00000000 00000000 [107061.117302@0] Mem-Info: [107061.117306@0] Normal per-cpu: [107061.117310@0] CPU 0: hi: 186, btch: 31 usd: 102 [107061.117313@0] CPU 1: hi: 186, btch: 31 usd: 97 [107061.117317@0] CPU 2: hi: 186, btch: 31 usd: 168 [107061.117320@0] CPU 3: hi: 186, btch: 31 usd: 36 [107061.117330@0] active_anon:405222 inactive_anon:32475 isolated_anon:0 [107061.117330@0] active_file:28 inactive_file:58 isolated_file:0 [107061.117330@0] unevictable:0 dirty:0 writeback:0 unstable:0 [107061.117330@0] free:4182 slab_reclaimable:1263 slab_unreclaimable:3416 [107061.117330@0] mapped:251 shmem:33452 pagetables:1130 bounce:0 [107061.117330@0] free_cma:0 [107061.117349@0] Normal free:16728kB min:16384kB low:20480kB high:24576kB active_anon:1620888kB inactive_anon:129900kB active_file:112kB inactive_file:232kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:2052096kB managed:1863964kB mlocked:0kB dirty:0kB writeback:0kB mapped:1004kB shmem:133808kB slab_reclaimable:5052kB slab_unreclaimable:13664kB kernel_stack:3216kB pagetables:4520kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:32 all_unreclaimable? no [107061.117353@0] lowmem_reserve[]: 0 0 [107061.117358@0] Normal: 90*4kB (UEM) 142*8kB (UEM) 82*16kB (UEM) 105*32kB (UEM) 55*64kB (UEM) 39*128kB (UEM) 4*256kB (UM) 2*512kB (U) 0*1024kB 0*2048kB 0*4096kB = 16728kB [107061.117380@0] 33675 total pagecache pages [107061.117382@0] 513024 pages RAM [107061.117385@0] 0 pages HighMem/MovableOnly [107061.117388@0] 47033 pages reserved [107061.117391@0] [ pid ] uid tgid total_vm rss nr_ptes swapents oom_score_adj name [107061.117419@0] [ 1747] 0 1747 721 29 5 0 0 sh [107061.117425@0] [ 1748] 0 1748 5546 265 8 0 0 systemd-journal [107061.117433@0] [ 2130] 0 2130 887 55 6 0 0 rpcbind [107061.117441@0] [ 2415] 0 2415 2078 172 6 0 -1000 systemd-udevd [107061.117448@0] [ 2424] 0 2424 1210 64 7 0 0 systemd-logind [107061.117454@0] [ 2432] 0 2432 39156 279 13 0 0 pulseaudio [107061.117461@0] [ 2433] 0 2433 764 36 6 0 0 eventlircd [107061.117468@0] [ 2441] 81 2441 1081 129 6 0 -900 dbus-daemon [107061.117474@0] [ 2456] 0 2456 721 23 6 0 0 crond [107061.117481@0] [ 2457] 0 2457 1197 101 6 0 -1000 sshd [107061.117487@0] [ 2483] 0 2483 1455 126 6 0 0 connmand [107061.117493@0] [ 2510] 495 2510 1157 91 6 0 0 avahi-daemon [107061.117499@0] [ 2520] 0 2520 1692 140 7 0 0 wpa_supplicant [107061.117505@0] [ 2526] 0 2526 394 17 3 0 0 brcm_patchram_p [107061.117512@0] [ 2551] 0 2551 2117 133 8 0 0 smbd [107061.117518@0] [ 2556] 0 2556 2113 112 8 0 0 nmbd [107061.117525@0] [ 2589] 0 2589 721 34 5 0 0 kodi.sh [107061.117531@0] [ 2596] 0 2596 992087 378691 875 0 0 kodi.bin [107061.117538@0] [ 4475] 0 4475 451931 23124 106 0 0 tvheadend [107061.117545@0] [ 4595] 0 4595 1006 28 5 0 0 oscam [107061.117550@0] [ 4611] 0 4611 268059 430 25 0 0 oscam [107061.117557@0] Out of memory: Kill process 2596 (kodi.bin) score 790 or sacrifice child [107061.117575@0] Killed process 2596 (kodi.bin) total-vm:3968348kB, anon-rss:1514764kB, file-rss:0kB [107061.967543@0] tv_vout: vout [tv_set_vframe_rate_end_hint] return mode = 18, policy = 1! [107061.967649@1] DI: di_receiver_event_fun , is_bypass() 0 trick_mode 0 bypass_all 0 [107061.967655@1] DI: disabled, not keep buffer. [107061.967659@1] DI: di_receiver_event_fun: vf_notify_receiver unreg [107061.967676@1] codec:DisableVideoLayer() [107061.967680@1] codec:free_alloced_keep_buffer (null). (null). (null) [107061.967684@1] codec:keep exit is di [107061.967688@1] [tsync_avevent]event:2, param 0 [107061.967693@1] codec:video first pts = 0 [107061.974739@0] codec:VsyncDisableVideoLayer [107061.978025@1] codec:vdec1 video changed to 0 x 0 0 fps clk->200MHZ [107065.157204@3] aml_spdif_dai: aml_hw_iec958_init,runtime->rate=44100, runtime->channels=2, same source mode(1) [107065.157215@3] aml_spdif_dai: share the same clock [107065.157225@3] aml_audio_hw: IEC958 PCM32 [107065.157231@3] hdmitx: audio: aout notify rate 44100 [107065.157234@3] hdmitx: audio: aout notify size 32 [107065.157239@3] hdmtix: set audio [107065.157252@3] hdmitx tx_aud_src = 0 [107065.157277@3] hdmitx: fs = 2, cd = 4, tmds_clk = 148500 [107065.157281@3] hdmitx aud_n_para = 6272 [107065.157299@3] hdmitx set channel status [107065.157357@3] hdmitx: audio: Audio Type: PCM [107065.157360@3] hdmitx: audio: set audio param [107065.157370@3] aml_snd_m8_card aml_m8_snd.45: i2s/958 same source [107065.157488@0] aml_snd_card: audio speaker on [107065.167662@0] aml_spdif_dai: aml_hw_iec958_init,runtime->rate=44100, runtime->channels=2, same source mode(1) [107065.167670@0] aml_spdif_dai: share the same clock [107065.167679@0] aml_audio_hw: IEC958 PCM32 [107065.167684@0] hdmitx: audio: aout notify rate 44100 [107065.167687@0] hdmitx: audio: aout notify size 32 [107065.167690@0] hdmitx: audio: no update [107065.167700@0] aml_snd_m8_card aml_m8_snd.45: i2s/958 same source [107065.167829@0] channel count should be 8, we got 2 aborting [107065.172015@0] aml_snd_m8_card aml_m8_snd.45: I2S playback enable [107065.172030@0] aml_snd_m8_card aml_m8_snd.45: IEC958 playback enable [107065.297516@0] fb: osd[0] enable: 1 (kodi.bin) [107070.024802@3] codec:video_disable_store(1) [107070.024810@3] codec:DisableVideoLayer() [107070.024846@3] vfm_map_store:rm default [107070.024870@3] vfm_map_store:add default [107070.025871@3] vfm_map_store:rm default [107070.025890@3] vfm_map_store:add default decoder ppmgr deinterlace amlvideo amvideo [107070.026372@3] codec:Video stbuf alloced at 0000000076800000, size = 15728640 [107070.034757@0] codec:H264 sysinfo: 1920x1080 duration=3840, pts_outside=1, [107070.034757@0] codec:VsyncDisableVideoLayer [107070.050833@1] DI: di_receiver_event_fun: vframe provider reg [107070.060984@1] tv_vout: vout [tv_set_vframe_rate_hint] duration = 3840, policy = 1! [107070.060997@1] tv_vout: vout [framerate_automation_process] duration = 3840 [107070.061002@1] tv_vout: framerate_automation_process[1111] fps_playing_flag = 0 [107070.061005@1] tv_vout: fr_vsource = 2500 [107070.061016@1] tv_vout: mode_target=18,is_receiver_supported=1 [107070.061597@1] codec:video first pts = 0 [107070.061760@1] [tsync_avevent]event:1, param 1 [107070.061768@1] video pause! [107070.065356@1] codec:video_freerun_mode_store(1) [107070.065587@1] codec:video first checkin pts = 22b81 [107070.065589@1] codec:first check in vpts <0x94:0x22b81> ok! [107070.069638@0] codec:Enter set parameter cmd1. [107070.070718@0] codec:vdec1 video changed to 3840 x 2160 60 fps clk->648MHZ [107070.070724@0] codec:actual_dpb_size 15 max_dpb_size 5 [107070.070806@0] codec:video first pts = 22b81 [107070.217977@0] pre_de_buf_config: source change: 0x0/0/0/0=>0x8009/1920/1080/0 [107070.233038@0] aml_snd_m8_card aml_m8_snd.45: I2S playback disable [107070.233044@0] aml_snd_m8_card aml_m8_snd.45: IEC958 playback disable [107070.233108@0] aml_spdif_dai: aml_hw_iec958_init,runtime->rate=44100, runtime->channels=2, same source mode(1) [107070.233112@0] aml_spdif_dai: share the same clock [107070.233121@0] aml_audio_hw: IEC958 PCM32 [107070.233127@0] hdmitx: audio: aout notify rate 44100 [107070.233129@0] hdmitx: audio: aout notify size 32 [107070.233131@0] hdmitx: audio: no update [107070.233134@0] aml_snd_m8_card aml_m8_snd.45: i2s/958 same source [107070.234757@0] de_post_process post_buf[1] is in post free list. [107070.240537@0] aml_spdif_dai: aml_hw_iec958_init,runtime->rate=48000, runtime->channels=2, same source mode(1) [107070.240565@0] aml_spdif_dai: share the same clock [107070.240584@0] aml_audio_hw: IEC958 PCM32 [107070.240594@0] hdmitx: audio: aout notify rate 48000 [107070.240599@0] hdmitx: audio: aout notify size 32 [107070.240605@0] hdmtix: set audio [107070.240626@0] hdmitx tx_aud_src = 0 [107070.240679@0] hdmitx: fs = 3, cd = 4, tmds_clk = 148500 [107070.240684@0] hdmitx aud_n_para = 6144 [107070.240711@0] hdmitx set channel status [107070.240796@0] hdmitx: audio: Audio Type: PCM [107070.240802@0] hdmitx: audio: set audio param [107070.240819@0] aml_snd_m8_card aml_m8_snd.45: i2s/958 same source [107070.242895@0] aml_spdif_dai: aml_hw_iec958_init,runtime->rate=48000, runtime->channels=2, same source mode(1) [107070.242913@0] aml_spdif_dai: share the same clock [107070.242928@0] aml_audio_hw: IEC958 PCM32 [107070.242937@0] hdmitx: audio: aout notify rate 48000 [107070.242940@0] hdmitx: audio: aout notify size 32 [107070.242945@0] hdmitx: audio: no update [107070.242962@0] aml_snd_m8_card aml_m8_snd.45: i2s/958 same source [107070.243096@0] channel count should be 8, we got 2 aborting [107070.243895@0] aml_snd_m8_card aml_m8_snd.45: I2S playback enable [107070.243912@0] aml_snd_m8_card aml_m8_snd.45: IEC958 playback enable [107070.254763@0] de_post_process post_buf[1] is in post free list. [107070.274766@0] de_post_process post_buf[1] is in post free list. [107070.294759@0] de_post_process post_buf[1] is in post free list. [107070.314766@0] de_post_process post_buf[1] is in post free list. [107070.334756@0] de_post_process post_buf[1] is in post free list. [107070.354766@0] de_post_process post_buf[1] is in post free list. [107070.374762@0] de_post_process post_buf[1] is in post free list. [107070.394757@0] de_post_process post_buf[1] is in post free list. [107070.414759@0] de_post_process post_buf[1] is in post free list. [107070.434756@0] de_post_process post_buf[1] is in post free list. [107070.454770@0] de_post_process post_buf[1] is in post free list. [107070.474755@0] de_post_process post_buf[1] is in post free list. [107070.494754@0] de_post_process post_buf[1] is in post free list. [107070.514758@0] de_post_process post_buf[1] is in post free list. [107070.534755@0] de_post_process post_buf[1] is in post free list. [107070.554751@0] de_post_process post_buf[1] is in post free list. [107070.574755@0] de_post_process post_buf[1] is in post free list. [107070.594755@0] de_post_process post_buf[1] is in post free list. [107070.614755@0] de_post_process post_buf[1] is in post free list. [107070.634753@0] de_post_process post_buf[1] is in post free list. [107070.654758@0] de_post_process post_buf[1] is in post free list. [107070.674756@0] de_post_process post_buf[1] is in post free list. [107070.694754@0] de_post_process post_buf[1] is in post free list. [107070.714757@0] de_post_process post_buf[1] is in post free list. [107070.734754@0] de_post_process post_buf[1] is in post free list. [107070.754756@0] de_post_process post_buf[1] is in post free list. [107070.774756@0] de_post_process post_buf[1] is in post free list. [107070.794752@0] de_post_process post_buf[1] is in post free list. [107070.814757@0] de_post_process post_buf[1] is in post free list. [107070.834753@0] de_post_process post_buf[1] is in post free list. [107070.854756@0] de_post_process post_buf[1] is in post free list. [107070.874756@0] de_post_process post_buf[1] is in post free list. [107070.894758@0] de_post_process post_buf[1] is in post free list. [107070.914757@0] de_post_process post_buf[1] is in post free list. [107070.934759@0] de_post_process post_buf[1] is in post free list. [107070.954759@0] de_post_process post_buf[1] is in post free list. [107070.974756@0] de_post_process post_buf[1] is in post free list. [107070.994759@0] de_post_process post_buf[1] is in post free list. [107071.014758@0] de_post_process post_buf[1] is in post free list. [107071.034759@0] de_post_process post_buf[1] is in post free list. [107071.054757@0] de_post_process post_buf[1] is in post free list. [107071.074753@0] de_post_process post_buf[1] is in post free list. [107071.094750@0] de_post_process post_buf[1] is in post free list. [107071.114751@0] de_post_process post_buf[1] is in post free list. [107071.134754@0] de_post_process post_buf[1] is in post free list. [107071.154754@0] de_post_process post_buf[1] is in post free list. [107071.174749@0] de_post_process post_buf[1] is in post free list. [107071.194756@0] de_post_process post_buf[1] is in post free list. [107071.214753@0] de_post_process post_buf[1] is in post free list. [107071.234757@0] de_post_process post_buf[1] is in post free list. [107071.254758@0] de_post_process post_buf[1] is in post free list. [107071.274758@0] de_post_process post_buf[1] is in post free list. [107071.294761@0] de_post_process post_buf[1] is in post free list. [107071.314754@0] de_post_process post_buf[1] is in post free list. [107071.334759@0] de_post_process post_buf[1] is in post free list. [107071.354758@0] de_post_process post_buf[1] is in post free list. [107071.374759@0] de_post_process post_buf[1] is in post free list. [107071.394757@0] de_post_process post_buf[1] is in post free list. [107071.414758@0] de_post_process post_buf[1] is in post free list. [107071.434755@0] de_post_process post_buf[1] is in post free list. [107071.454758@0] de_post_process post_buf[1] is in post free list. [107071.474757@0] de_post_process post_buf[1] is in post free list. [107071.494756@0] de_post_process post_buf[1] is in post free list. [107071.514757@0] de_post_process post_buf[1] is in post free list. [107071.534757@0] de_post_process post_buf[1] is in post free list. [107071.554757@0] de_post_process post_buf[1] is in post free list. [107071.574755@0] de_post_process post_buf[1] is in post free list. [107071.594761@0] de_post_process post_buf[1] is in post free list. [107071.614757@0] de_post_process post_buf[1] is in post free list. [107071.634759@0] de_post_process post_buf[1] is in post free list. [107071.654754@0] de_post_process post_buf[1] is in post free list. [107071.674755@0] de_post_process post_buf[1] is in post free list. [107071.694759@0] de_post_process post_buf[1] is in post free list. [107071.714756@0] de_post_process post_buf[1] is in post free list. [107071.734756@0] de_post_process post_buf[1] is in post free list. [107071.754760@0] de_post_process post_buf[1] is in post free list. [107071.774757@0] de_post_process post_buf[1] is in post free list. [107071.794759@0] de_post_process post_buf[1] is in post free list. [107071.814758@0] de_post_process post_buf[1] is in post free list. [107071.834759@0] de_post_process post_buf[1] is in post free list. [107071.854759@0] de_post_process post_buf[1] is in post free list. [107071.874762@0] de_post_process post_buf[1] is in post free list. [107071.876937@0] codec:video_disable_store(0) [107071.894747@0] vpts to scr, apts = 0x0, vpts = 0x22b81 [107071.894777@0] codec:[video4osd] first picture {1920,1080} pts:23991, [107071.914769@0] codec:VsyncEnableVideoLayer [107074.475312@0] vidioc_qbuf skip: index:1798912:1798909 [107074.475401@0] vidioc_qbuf skip: index:1798912:1798910 [107074.475414@0] vidioc_qbuf skip: index:1798912:1798911 [107074.697066@0] codec:finished correct frame dur [107074.697083@0] codec: new=3840,old_duration=3840,cnt=25