Short dump in timers.c, cString cTimer::ToDescr(void) const

MarkusE · 18. Dezember 2022

Hallo,

in "timers.c, cString cTimer::ToDescr(void) const"

tritt ein short dump auf, wenn Channel() "null" zurückgibt. Es dumpt dann bei Channel()->Number() .

Auch wenn ich nicht weiß, wie es dazu kommen konnte. Ist hier passiert. Bei Verwendung von EPG search, und Aufruf der Suchergebnisse. Ich habe es danach noch mal gemacht (gleiche Suche), und da gab es dann keinen Dump mehr.

Dump:

Code

Core was generated by `/usr/bin/vdr'.                                                                                                                             
Program terminated with signal SIGSEGV, Segmentation fault.
#0  0x000000555eff853c in cChannel::Number (this=0x0) at channels.h:178      
178       int Number(void) const { return number; }                                                                                                               
[Current thread is 1 (Thread 0x7f937fe0e0 (LWP 981596))]                                                                                                          
(gdb) bt full                                                                                                                                                     
#0  0x000000555eff853c in cChannel::Number (this=0x0) at channels.h:178
No locals.                                                                       
#1  cTimer::ToDescr (this=this@entry=0x7f84088c60) at timers.c:323
No locals.                                                                                                                                                        
#2  0x000000555eff94e8 in cTimer::SetEvent (this=this@entry=0x7f84088c60, Event=Event@entry=0x7fa4c7a9e0) at timers.c:912
No locals.                                                                       
#3  0x000000555eff9f38 in cTimer::cTimer (this=0x7f84088c60, Event=0x7fa4c7a9e0, FileName=0x7fa4829380 "Tatort: Das Opfer", PatternTimer=0x0) at timers.c:219     
        Channels = <optimized out>                                                                                                                                
        tstart = 1671494520                                                                                                                                       
        tm_r = {tm_sec = 0, tm_min = 47, tm_hour = 2, tm_mday = 20, tm_mon = 11, tm_year = 122, tm_wday = 2, tm_yday = 353, tm_isdst = 0, tm_gmtoff = 3600, 
          tm_zone = 0x559139f310 "CET"}                                                                                                                           
        Channels_Lock = {stateKey = {stateLock = 0x555f097e88 <cChannels::channels+32>, write = false, state = -1, timedOut = false}, 
          list = 0x555f097e68 <cChannels::channels>}                                                                                                              
        tstop = 1671500820
        time = <optimized out>
        Channels_Lock = {stateKey = {stateLock = <optimized out>, write = <optimized out>, state = <optimized out>, timedOut = <optimized out>}, 
          list = <optimized out>}
        Channels = <optimized out>
        tstart = <optimized out>
        tstop = <optimized out>
        tm_r = {tm_sec = <optimized out>, tm_min = <optimized out>, tm_hour = <optimized out>, tm_mday = <optimized out>, tm_mon = <optimized out>, 
          tm_year = <optimized out>, tm_wday = <optimized out>, tm_yday = <optimized out>, tm_isdst = <optimized out>, tm_gmtoff = <optimized out>, 
          tm_zone = <optimized out>}
        time = <optimized out>
        MarginStart = <optimized out>
        MarginStop = <optimized out>
#4  0x0000007fb9b45928 in cEpgsearchServiceHandler::TranslateResults[abi:cxx11](cSearchResults*) (this=<optimized out>, pCompleteSearchResults=<optimized out>)
    at services.c:116
        Timer = <optimized out>
        hasTimer = <optimized out>
        pEvent = 0x7fa4c7a9e0
        timerMatch = tmNone
        cmdbuf = {_vptr.cString = 0x555f082d98 <vtable for cString+16>, 
          s = 0x7f84093360 "25:98600:Macht des Geldes:El reino:Genre| Thriller\nKategorie| Spielfilm\nLand| E/F\nJahr| 2018\n\nEin korrupter Politiker kämpft ums 
Überleben.\n\nSehr empfehlenswert, Faszinierende, fiebrige Reise in ein"...}
--Type <RET> for more, q to quit, c to continue without paging--
        bufStart = "0053", '\000' <repeats 20 times>
        eStart = <optimized out>
        eStop = <optimized out>
        start = 1671493980
        Timers = <optimized out>
        Channels_Lock = {stateKey = {stateLock = 0x0, write = false, state = 70, timedOut = false}, list = 0x555f097e68 <cChannels::channels>}
        shorttext = "El reino"
        tm_r = {tm_sec = 0, tm_min = 10, tm_hour = 3, tm_mday = 20, tm_mon = 11, tm_year = 122, tm_wday = 2, tm_yday = 353, tm_isdst = 0, tm_gmtoff = 3600, 
          tm_zone = 0x559139f310 "CET"}
        stop = 1671502200
        Timers_Lock = {stateKey = {stateLock = 0x0, write = false, state = 76, timedOut = false}, list = 0x555f0f9190 <cTimers::timers>}
Channels = <optimized out>                                                                                                                                
        channel = <optimized out>                                                
        bufEnd = "0310", '\000' <repeats 20 times>                                                                                                                
        timerMode = <optimized out>                                              
        title = "0z\005\204\177\000\000\000\320\b\000\204\177\000\000"       
        description = "\000\005\000\204\177\000\000\000\000\005\000\204\177\000\000\000\260\360\b\204\177\000\000\000\260\360\b\204\177\000\000\000film\nLand| E/F
\nJahr| 2018\n\nEin korrupter Politiker kämpft ums Überleben.\n\nSehr empfehlenswert, Faszinierende, fiebrige Reise in eine völlig korrupte Welt\n\n\nTipp\n / S".
..                                                                                                                                                                
        result = 0x7f84062180                                                    
Python Exception <class 'gdb.error'> value has been optimized out:               
        list = std::__cxx11::list                                                
#5  0x0000007fb9b43d74 in cEpgsearchServiceHandler::QuerySearchTimer[abi:cxx11](int) (this=0x7f84006de0, ID=<optimized out>) at services.c:186                    
        list = empty std::__cxx11::list                                                                                                                           
        pCompleteSearchResults = 0x7f84037b00                                    
        search = <optimized out>                                                                                                                                  
#6  0x0000007fb98c3c58 in vdrlive::SearchResults::GetByID (this=this@entry=0x7f937fa038, id=25) at epgsearch.cpp:601                                              
        service = {handler = std::unique_ptr<cServiceHandler> = {get() = 0x7f84006de0}}                                                                           
        list = empty std::__cxx11::list                                                                                                                           
#7  0x0000007fb9949238 in (anonymous namespace)::_component_::operator() (this=0x7f4c01cdc0, request=..., reply=..., qparam=...) at searchresults.ecpp:34         
        display_pictures = <optimized out>                                                                                                                        
        epg_itemS = {m_s = 0x7f84006e00 "\240", m_string_end = 0x1d <error: Cannot access memory at address 0x1d>,                                                
          m_buffer_end = 0x1d <error: Cannot access memory at address 0x1d>, m_increaseSize = 495874504051, m_maxSize = 547935462528, 
          m_name = "\300S\202\271\177\000\000\000\001\000\000\000\000\000\000\000\340\033\000\214\177\000\000\000\000T\202\271\177\000\000\000`\v\000\214\177\000\
000\000\370N\202\271\177\000\000\000\001\000\000\000\377\377\377\377\377\377\377\377\020\000\000\000\000\000\000\000\022", '\000' <repeats 11 times>, "\200\201\00
0\214\177\000\000\000\200\201\000\214\177", '\000' <repeats 11 times>, "P\030\003\214\177\000\000\000\340\340\177\223\177\000\000\000\060\246\177\271\177\000\000\

Alles anzeigen

~ Markus

MarkusE · 18. Dezember 2022

Ergänzung:

Der Fehler trat kurz nach dem Start von VDR auf. Also, ich habe die Suche gestartet, während VDR noch die timer den events zugeordnet hat. Aus dem syslog:

Code

Dec 18 12:56:42 rpi4s vdr: [981596] timer 0 (30 2212-2355 'Tatort: Schneetreiben') set to event Mo. 19.12.2022 22:15-23:45 (VPS: 19.12. 22:15) 'Tatort: Schneetreiben'
Dec 18 12:56:42 rpi4s vdr: [981596] timer 0 (13 2217-0020 'Men in Black') set to event Mo. 19.12.2022 22:20-00:10 'Men in Black'
Dec 18 12:56:42 rpi4s vdr: [981596] timer 0 (16 2352-0135 'Stenzels Bescherung') set to event Mo. 19.12.2022 23:55-01:25 (VPS: 19.12. 23:55) 'Stenzels Bescherung'
Dec 18 12:56:42 rpi4s vdr: [981596] timer 0 (12 0004-0221 'Platoon') set to event Di. 20.12.2022 00:07-02:19 'Platoon'
Dec 18 12:56:42 rpi4s vdr: [981596] timer 0 (17 0052-0310 'Macht des Geldes') set to event Di. 20.12.2022 00:55-03:00 (VPS: 20.12. 00:55) 'Macht des Geldes'
Dec 18 12:56:42 rpi4s systemd[1]: Started Process Core Dump (PID 981665/UID 0).
Dec 18 12:56:51 rpi4s systemd-coredump[981666]: Process 981584 (vdr) of user 200 dumped core.#012#012Stack trace of thread 981596:#012#0  0x000000555eff853c _ZNK8cChannel6NumberEv (vdr + 0x16853c)#012#1  0x000000555eff94e8 _ZN6cTimer8SetEventEPK6cEvent (vdr + 0x1694e8)#012#2  0x000000555eff9f38 _ZN6cTimerC2EPK6cEventPKcPKS_ (vdr + 0x169f38)#012#3  0x0000007fb9b45928 _ZN24cEpgsearchServiceHandler16TranslateResultsB5cxx11EP14cSearchResults (libvdr-epgsearch.so.2.6.2 + 0xbd928)#012#4  0x0000007fb9b43d74 _ZN24cEpgsearchServiceHandler16QuerySearchTimerB5cxx11Ei (libvdr-epgsearch.so.2.6.2 + 0xbbd74)#012#5  0x0000007fb98c3c58 _ZN7vdrlive13SearchResults7GetByIDEi (libvdr-live.so.2.6.2 + 0x84c58)#012#6  0x0000007fb9949238 operator() (libvdr-live.so.2.6.2 + 0x10a238)#012#7  0x0000007fb97f1900 _ZN3tnt6Worker8dispatchERNS_11HttpRequestERNS_9HttpReplyE (libtntnet.so.12 + 0x84900)#012#8  0x0000007fb97f2a98 _ZN3tnt6Worker14processRequestERNS_11HttpRequestERSdj (libtntnet.so.12 + 0x85a98)#012#9  0x0000007fb97f3640 _ZN3tnt6Worker3runEv (libtntnet.so.12 + 0x86640)#012#10 0x0000007fb97f43dc _ZN8cxxtools14DetachedThread4execEv (libtntnet.so.12 + 0x873dc)#012#11 0x0000007fb96f40c0 n/a (libcxxtools.so.9 + 0xd00c0)#012#12 0x0000007fbb403648 start_thread (libpthread.so.0 + 0x7648)#012#13 0x0000007fbaea5c1c thread_start (libc.so.6 + 0xd2c1c)#012#012Stack trace of thread 981588:#012#0  0x0000007fbb40a794 futex_abstimed_wait_cancelable (libpthread.so.0 + 0xe794)#012#1  0x000000555eff3270 _ZN8cCondVar9TimedWaitER6cMutexi (vdr + 0x163270)#012#2  0x000000555ef5a9cc _ZN9cDvbTuner6ActionEv (vdr + 0xca9cc)#012#3  0x000000555eff3984 _ZN7cThread11StartThreadEPS_ (vdr + 0x163984)#012#4  0x0000007fbb403648 start_thread (libpthread.so.0 + 0x7648)#012#5  0x0000007fbaea5c1c thread_start (libc.so.6 + 0xd2c1c)#012#012Stack trace of thread 981607:#012#0  0x0000007fbae9bef4 __GI___poll (libc.so.6 + 0xc8ef4)#012#1  0x0000007fbb495390 n/a (libmediaclient.so + 0x2390)#012#2  0x0000007fbb495390 n/a (libmediaclient.so + 0x2390)#012#3  0x0000007fbb497e40 poll (libmediaclient.so + 0x4e40)#012#4  0x000000555f000714 _ZN7cPoller4PollEi (vdr + 0x170714)#012#5  0x000000555eff3984 _ZN7cThread11StartThreadEPS_ (vdr + 0x163984)#012#6  0x0000005591646660 n/a (n/a + 0x0)
Dec 18 12:56:51 rpi4s systemd[1]: systemd-coredump@1-981665-0.service: Succeeded.
Dec 18 12:56:51 rpi4s mariadbd[92898]: 2022-12-18 12:56:51 583 [Warning] Aborted connection 583 to db: 'epg2vdr' user: 'epg2vdr' host: '192.168.178.33' (Got an error reading communication packets)
Dec 18 12:56:51 rpi4s mariadbd[92898]: 2022-12-18 12:56:51 582 [Warning] Aborted connection 582 to db: 'epg2vdr' user: 'epg2vdr' host: '192.168.178.33' (Got an error reading communication packets)

kls · 18. Dezember 2022

Bau bitte mal das hier ein und schau, ob die Meldung kommt:

Diff

--- timers.c    2022/11/20 10:57:31     5.18
+++ timers.c    2022/12/18 14:51:54
@@ -192,6 +192,10 @@
      }
   LOCK_CHANNELS_READ;
   channel = Channels->GetByChannelID(Event->ChannelID(), true);
+  if (!channel) {
+     esyslog("ERROR: channel '%s' not found!", *Event->ChannelID().ToString());
+     return;
+     }
   time_t tstart = (flags & tfVps) ? Event->Vps() : Event->StartTime();
   time_t tstop = tstart + Event->Duration();
   if (!(HasFlags(tfVps))) {

Alles anzeigen

MarkusE · 18. Dezember 2022

Hi Klaus,

Ich habe das eingebaut. Kann jetzt den Fehler aber nicht mehr reproduzieren . Na ja, ich beobachte das mal.

~ Markus

kls · 15. Februar 2023

MarkusE Nachdem der Fehler anscheinend nicht (mehr) auftritt gehe ich mal davon aus, dass es nicht daran gelegen hat. Wäre auch unwahrscheinlich, denn wenn es einen Event gibt, dann *muss* es auch einen Channel dafür geben.

MarkusE · 15. Februar 2023

Hi Klaus,

Ich habe Deinen Patch noch drin, diese Fehler ist aber nicht mehr aufgetreten.

~ Markus

Short dump in timers.c, cString cTimer::ToDescr(void) const

Jetzt mitmachen!

Teilen