[Letux-kernel] Debugging 4.11-rc6 on GTA04

H. Nikolaus Schaller hns at goldelico.com
Mon Apr 10 22:21:52 CEST 2017


> Am 10.04.2017 um 22:01 schrieb H. Nikolaus Schaller <hns at goldelico.com>:
> 
> 
>> Am 10.04.2017 um 20:13 schrieb H. Nikolaus Schaller <hns at goldelico.com>:
>> 
>> Hi,
>> I have found a little time to upgrade our tree to 4.11-rc6
>> and for the first time there were no kernel oops on the GTA04(A5)
>> until login.
>> 
>> Only the LCD is broken :(
>> 
>> On the Pyra the same kernel works well. So it seems to be
>> OMAP3 specific (maybe again some interference of the TILER
>> addition, but I can easily check by merging my 4.11-rc6
>> without TILER).
> 
> I have now built w/o TILER

Here: http://git.goldelico.com/?p=gta04-kernel.git;a=shortlog;h=refs/heads/letux-4.11-rc6-tiler-fbdev-sgx544

> and for the first two boot attempts I had the
> same error. But the third one succeeded. This time I got
> 
> [   16.892059] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
> [   16.892059] [drm] No driver support for vblank timestamp query.
> [   17.118347] ------------[ cut here ]------------
> [   17.118408] WARNING: CPU: 0 PID: 3 at drivers/regulator/core.c:2272 _regulator_disable+0x78/0x17c
> [   17.118438] unbalanced disables for VUSB1V8
> [   17.118438] Modules linked in: omapdrm(+) drm_kms_helper cfbfillrect syscopyarea cfbimgblt sysfillrect sysimgblt fb_sys_fops cfbcopyarea panel_tpo_td028ttec1 snd_soc_simple_card drm snd_soc_simple_card_utils snd_soc_omap_twl4030 encoder_opa362 twl4030_madc_hwmon wwan_on_off w1_bq27000 snd_soc_gtm601 pwm_omap_dmtimer connector_analog_tv pwm_bl generic_adc_battery extcon_gpio omap3_isp videobuf2_dma_contig wlcore_sdio videobuf2_memops videobuf2_v4l2 videobuf2_core omap_hdq omap2430 ov9650 v4l2_common snd_soc_omap_mcbsp snd_soc_omap snd_pcm_dmaengine bmp280_i2c at24 bmg160_i2c bmp280 phy_twl4030_usb bmc150_magn_i2c bmg160_core videodev bmc150_accel_i2c nvmem_core bmc150_accel_core bmc150_magn industrialio_triggered_buffer media kfifo_buf bno055 musb_hdrc leds_tca6507 tsc2007 gpio_twl4030 snd_soc_twl4030
> [   17.118835]  twl4030_madc twl4030_vibra twl4030_charger twl4030_pwrbutton industrialio ehci_omap(+) omapdss
> [   17.118896] CPU: 0 PID: 3 Comm: kworker/0:0 Not tainted 4.11.0-rc6-letux+ #938
> [   17.118896] Hardware name: Generic OMAP36xx (Flattened Device Tree)
> [   17.118927] Workqueue: pm pm_runtime_work
> [   17.118957] [<c010f378>] (unwind_backtrace) from [<c010b8fc>] (show_stack+0x10/0x14)
> [   17.118988] [<c010b8fc>] (show_stack) from [<c043e080>] (dump_stack+0x98/0xd0)
> [   17.119018] [<c043e080>] (dump_stack) from [<c012f458>] (__warn+0xd0/0x100)
> [   17.119018] [<c012f458>] (__warn) from [<c012f4bc>] (warn_slowpath_fmt+0x34/0x44)
> [   17.119049] [<c012f4bc>] (warn_slowpath_fmt) from [<c04aac6c>] (_regulator_disable+0x78/0x17c)
> [   17.119079] [<c04aac6c>] (_regulator_disable) from [<c04aada0>] (regulator_disable+0x30/0x60)
> [   17.119110] [<c04aada0>] (regulator_disable) from [<bf1a1d08>] (twl4030_usb_runtime_suspend+0x24/0x34 [phy_twl4030_usb])
> [   17.119201] [<bf1a1d08>] (twl4030_usb_runtime_suspend [phy_twl4030_usb]) from [<c04f14b8>] (__rpm_callback+0x110/0x1cc)
> [   17.119201] [<c04f14b8>] (__rpm_callback) from [<c04f15dc>] (rpm_callback+0x68/0x80)
> [   17.119232] [<c04f15dc>] (rpm_callback) from [<c04f041c>] (rpm_suspend+0x2b4/0x5cc)
> [   17.119232] [<c04f041c>] (rpm_suspend) from [<c04f1af4>] (pm_runtime_work+0x74/0x8c)
> [   17.119262] [<c04f1af4>] (pm_runtime_work) from [<c014c5f0>] (process_one_work+0x384/0x764)
> [   17.119262] [<c014c5f0>] (process_one_work) from [<c014d9e0>] (worker_thread+0x2ac/0x3d4)
> [   17.119293] [<c014d9e0>] (worker_thread) from [<c01529b8>] (kthread+0x118/0x134)
> [   17.119323] [<c01529b8>] (kthread) from [<c01070d0>] (ret_from_fork+0x14/0x24)
> [   17.119323] ---[ end trace b89bf07085e22ab5 ]---
> 
> And the ethernet gadget was not loaded (initially). No VBUS event reported. But charger started charging.
> 
> After unplugging the USB cable I got:
> 
> root at letux:~# [  230.016326] musb-hdrc musb-hdrc.0.auto: VBUS_ERROR in b_idle (90, <VBusValid), retry #0, port1 00000100
> 
> And then:
> 
> [  237.857330] g_ether gadget: high-speed config #1: CDC Ethernet (ECM)
> [  238.624481] IPv6: ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready

This seems to be very reproducible (except that it this time complained about VUSB3V1 and not VUSB1V8):

[   16.139099] WARNING: CPU: 0 PID: 1080 at drivers/regulator/core.c:2272 _regulator_disable+0x78/0x17c
[   16.139129] unbalanced disables for VUSB3V1

root at letux:~# [   93.631256] musb-hdrc musb-hdrc.0.auto: VBUS_ERROR in b_idle (90, <VBusValid), retry #0, port1 00000100
[   96.402221] g_ether gadget: high-speed config #1: CDC Ethernet (ECM)
[   97.733398] IPv6: ADDRCONF(NETDEV_CHANGE): usb0: link becomes ready

root at letux:~# ping 8.8.8.8
PING 8.8.8.8 (8.8.8.8) 56(84) bytes of data.
64 bytes from 8.8.8.8: icmp_seq=14 ttl=56 time=12.0 ms
64 bytes from 8.8.8.8: icmp_seq=15 ttl=56 time=8.51 ms
64 bytes from 8.8.8.8: icmp_seq=16 ttl=56 time=9.00 ms


> 
> Otherwise I didn't see any significant issue.
> 
> So it looks as if we still have two bugs: one in musb and another one in TILER/crtc.

A third one is that it does not properly reboot from MMC if I use the "reboot" command.
It does not find the MMC any more in U-Boot.

If I "poweroff" and press the power button everything is fine. So it looks as if "reboot"
leaves the twl4030 in some invalid state.

> 
> I will do more tests asap.
> 
> BR,
> Nikolaus
> 
> 
> 
>> 
> 
>> Unfortunately the crtc_error makes the device almost unuseable after
>> the login:
>> 
>> The current code is here:
>> 
>> http://git.goldelico.com/?p=gta04-kernel.git;a=shortlog;h=refs/heads/letux-4.11-rc6
>> 
>> BR,
>> Nikolaus
>> 
>> 
>>  50.040313] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
>> [   50.056091] Bluetooth: BNEP socket layer initialized
>> [ ok ] Loading cpufreq kernel modules...done (none).
>> [ ok ] CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...done.
>> [ ok ] Starting NTP server: ntpd.
>> [ ok ] Starting OpenBSD Secure Shell server: sshd.
>> [FAIL] Starting ISC DHCP server: dhcpd[....] check syslog for diagnostics. ... failed!
>> failed!
>> [FAIL] startpar: service(s) returned failure: isc-dhcp-server ... failed!
>> [warn] startpar: service(s) skipped, program is not configured: dhcpcd ... (warning).
>> xauth:  file //.Xauthority does not exist
>> 
>> 
>> X.Org X Server 1.16.4
>> Release Date: 2014-12-20
>> X Protocol Version 11, Revision 0
>> Build Operating System: Linux 3.16.0-0.bpo.4-armmp-lpae armv7l Debian
>> Current Operating System: Linux letux 4.11.0-rc6-letux+ #937 SMP PREEMPT Mon Apr 10 15:39:28 CEST 2017 armv7l
>> Kernel command line: console=ttyO2,115200n8 mtdoops.mtddev=omap2.nand ubi.mtd=4 root=/dev/mmcblk0p1 rw rootfstype=ext4,ext3 rootwait console=ttyO2,115200n8 vram=12M omapfb.vram=0:8M,1:4M omapfb.rotate_type=0 omapdss.def_disp=lcd rootwait twl4030_charger.allow_usb=1 musb_hdrc.preserve_vbus=1 log_buf_len=8M ignore_loglevel earlyprintk
>> Build Date: 11 February 2015  01:18:06AM
>> xorg-server 2:1.16.4-1 (http://www.debian.org/support) 
>> Current version of pixman: 0.32.6
>>       Before reporting problems, check http://wiki.x.org
>>       to make sure that you have the latest version.
>> Markers: (--) probed, (**) from config file, (==) default setting,
>>       (++) from command line, (!!) notice, (II) informational,
>>       (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
>> (==) Log file: "/var/log/Xorg.0.log", Time: Sat Jan  1 00:00:49 2000
>> (==) Using config file: "/etc/X11/xorg.conf"
>> (==) Using system config directory "/usr/share/X11/xorg.conf.d"
>> 
>> Debian GNU/Linux 8 letux console
>> 
>> letux login: [   54.518096] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   54.524963] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   54.531616] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   54.538269] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   54.544921] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   54.551544] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   54.558197] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   54.564849] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   54.571502] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   54.578155] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [[   59.525634] omap_crtc_error_irq: 253751 callbacks suppressed
>> [   59.531799] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   59.538604] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   59.545227] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   59.551879] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   59.558563] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   59.565155] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   59.571777] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   59.578460] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   59.585052] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   59.591705] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> c[c[c[c[c[c[c[c[c[   64.535583] omap_crtc_error_irq: 280209 callbacks suppressed
>> [   64.541534] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   64.548248] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   64.554840] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   64.561492] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   64.568145] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   64.574737] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   64.581359] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   64.588012] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   64.594604] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   64.601257] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [c[c[c[c[c[c[c[c[c[c[c[c[c[   69.545532] omap_crtc_error_irq: 280535 callbacks suppressed
>> [   69.551483] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   69.558197] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   69.564788] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   69.571441] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   69.578094] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   69.584686] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   69.591308] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   69.597961] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   69.604553] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   69.611175] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   74.555541] omap_crtc_error_irq: 281570 callbacks suppressed
>> [   74.561492] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   74.568237] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   74.574829] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   74.581481] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   74.588165] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   74.594726] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   74.601409] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   74.608062] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   74.614654] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   74.621307] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   79.565551] omap_crtc_error_irq: 279723 callbacks suppressed
>> [   79.571502] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   79.578216] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   79.584808] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   79.591491] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   79.598144] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   79.604736] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   79.611419] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   79.618041] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   79.624664] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   79.631347] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   84.575531] omap_crtc_error_irq: 280870 callbacks suppressed
>> [   84.581512] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   84.588195] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   84.594787] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   84.601440] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   84.608093] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   84.614685] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   84.621307] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   84.627960] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   84.634552] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   84.641204] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   89.585510] omap_crtc_error_irq: 280307 callbacks suppressed
>> [   89.591491] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   89.598175] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   89.604797] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   89.611450] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   89.618103] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   89.624694] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   89.631347] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   89.638000] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> [   89.644622] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004022
>> [   89.651306] [drm:omap_crtc_error_irq] *ERROR* lcd: errors: 00004000
>> 
>> 
>> _______________________________________________
>> http://projects.goldelico.com/p/gta04-kernel/
>> Letux-kernel mailing list
>> Letux-kernel at openphoenux.org
>> http://lists.goldelico.com/mailman/listinfo.cgi/letux-kernel
> 
> _______________________________________________
> http://projects.goldelico.com/p/gta04-kernel/
> Letux-kernel mailing list
> Letux-kernel at openphoenux.org
> http://lists.goldelico.com/mailman/listinfo.cgi/letux-kernel



More information about the Letux-kernel mailing list