[Letux-kernel] Debugging 4.11-rc6 on GTA04

H. Nikolaus Schaller hns at goldelico.com
Mon Apr 10 22:01:28 CEST 2017


> 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 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

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.

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



More information about the Letux-kernel mailing list