Bug #4081
Selecting an scrambled channel (using HW CAM) causes crash
Status:
Fixed
Priority:
Normal
Assignee:
-
Category:
Descrambling
Target version:
-
Start date:
2016-11-15
Due date:
% Done:
100%
Estimated time:
Found in version:
HTS Tvheadend 4.1-2322~g879d532
Affected Versions:
Description
I have not used my HW CAM for a while but decided to give it a try. Updated to latest version but when I select an scrambled channel, tvh crash. The crash happends every time. The HW CAM tvh server acts as a SAT>IP server for another tvh server. Channels not using HW CAM works perfect. If any additional information is needed I can hopefully supply it.
2016-11-15 18:58:55.798 [ INFO]:subscription: 0003: "SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" subscribing to service "Teracom/570MHz/TV4 HD Göteborg", weight: 100, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", mux: "570MHz", provider: "TV4 AB", client="SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" 2016-11-15 18:58:55.829 [ ALERT]:CRASH: Signal: 11 in PRG: tvheadend (4.1-2322~g879d532) [736d1352ed61291565ac8fa4e052b01978dc9e35] CWD: / 2016-11-15 18:58:55.829 [ ALERT]:CRASH: Fault address 0x10 (Address not mapped) 2016-11-15 18:58:55.829 [ ALERT]:CRASH: Loaded libraries: /usr/lib/libdvben50221.so /usr/lib/libdvbapi.so /usr/lib/libucsi.so /lib/x86_64-linux-gnu/libssl.so.1.0.0 /lib/x86_64-linux-gnu/libcrypto.so.1.0.0 /lib/x86_64-linux-gnu/libz.so.1 /usr/lib/liburiparser.so.1 /usr/lib/x86_64-linux-gnu/libavahi-common.so.3 /usr/lib/x86_64-linux-gnu/libavahi-client.so.3 /lib/x86_64-linux-gnu/libdbus-1.so.3 /lib/x86_64-linux-gnu/libdl.so.2 /lib/x86_64-linux-gnu/libpthread.so.0 /lib/x86_64-linux-gnu/libm.so.6 /lib/x86_64-linux-gnu/librt.so.1 /usr/lib/x86_64-linux-gnu/libstdc++.so.6 /lib/x86_64-linux-gnu/libc.so.6 /lib64/ld-linux-x86-64.so.2 /lib/x86_64-linux-gnu/libgcc_s.so.1 /lib/x86_64-linux-gnu/libnss_compat.so.2 /lib/x86_64-linux-gnu/libnsl.so.1 /lib/x86_64-linux-gnu/libnss_nis.so.2 /lib/x86_64-linux-gnu/libnss_files.so.2 2016-11-15 18:58:55.829 [ ALERT]:CRASH: Register dump [23]: 00007fc74400183000007fc74402ec90000000005000709100000000000019db00007fc750006da100000000000002f000007fc74400165000007fc7440018300000000000000000000000000000005900007fc79780b7200000000000000001000000000000000000000000000000db0000000090db194700007fc76dffa6b000007fc796388e1d000000000001024600000000000000330000000000000004000000000000000efffffffe7ffbba110000000000000010 2016-11-15 18:58:55.829 [ ALERT]:CRASH: STACKTRACE 2016-11-15 18:58:55.850 [ ALERT]:CRASH: ??:0 0x7fc79631984d 2016-11-15 18:58:55.865 [ ALERT]:CRASH: ??:0 0x7fc794410330 2016-11-15 18:58:55.880 [ ALERT]:CRASH: ??:0 0x7fc796388e1d 2016-11-15 18:58:55.896 [ ALERT]:CRASH: ??:0 0x7fc7963808d9 2016-11-15 18:58:55.910 [ ALERT]:CRASH: ??:0 0x7fc796388ba5 2016-11-15 18:58:55.924 [ ALERT]:CRASH: ??:0 0x7fc79638678e 2016-11-15 18:58:55.939 [ ALERT]:CRASH: ??:0 0x7fc7962e20b2 2016-11-15 18:58:56.250 [ ERROR]:config: uknown subsystem 'pmt' 2016-11-15 18:58:56.250 [ INFO]:main: Log started 2016-11-15 18:58:56.252 [ INFO]:http: Starting HTTP server 0.0.0.0:9981 2016-11-15 18:58:56.252 [ INFO]:htsp: Starting HTSP server 0.0.0.0:9982 2016-11-15 18:58:56.252 [ ERROR]:satips: use --satip_bindaddr parameter to select the local IP for SAT>IP 2016-11-15 18:58:56.252 [ ERROR]:satips: using Google lookup (might block the task until timeout) 2016-11-15 18:58:56.269 [ INFO]:satips: Starting SAT>IP RTSP server 192.168.0.93:9983 2016-11-15 18:58:56.269 [ INFO]:satips: SAT>IP Server initialized 2016-11-15 18:58:56.269 [ INFO]:satips: HTTP 192.168.0.93:9981, RTSP 192.168.0.93:9983 2016-11-15 18:58:56.269 [ INFO]:satips: descramble 3, muxcnf 0 2016-11-15 18:58:56.269 [ INFO]:satips: tuner[fe=1]: DVB-T2 #1 2016-11-15 18:58:56.514 [ INFO]:config: loaded 2016-11-15 18:58:56.514 [ INFO]:config: scanfile (re)initialization with path <none> 2016-11-15 18:58:56.523 [ INFO]:linuxdvb: adapter added /dev/dvb/adapter0 2016-11-15 18:58:56.526 [ INFO]:dvr: Creating new configuration '' 2016-11-15 18:58:56.528 [ INFO]:csa: Using SSE2 128bit parallel descrambling 2016-11-15 18:58:56.528 [ INFO]:descrambler: adding CAID 2600 as constant crypto-word (BISS) 2016-11-15 18:58:56.528 [ INFO]:epggrab: module eit created 2016-11-15 18:58:56.528 [ INFO]:epggrab: module uk_freesat created 2016-11-15 18:58:56.528 [ INFO]:epggrab: module uk_freeview created 2016-11-15 18:58:56.528 [ INFO]:epggrab: module viasat_baltic created 2016-11-15 18:58:56.528 [ INFO]:epggrab: module Bulsatcom_39E created 2016-11-15 18:58:56.528 [ INFO]:epggrab: module psip created 2016-11-15 18:58:56.533 [ INFO]:epggrab: module opentv-skyit created 2016-11-15 18:58:56.534 [ INFO]:epggrab: module opentv-skynz created 2016-11-15 18:58:56.534 [ INFO]:epggrab: module opentv-ausat created 2016-11-15 18:58:56.534 [ INFO]:epggrab: module opentv-skyuk created 2016-11-15 18:58:56.536 [ INFO]:epggrab: module pyepg created 2016-11-15 18:58:56.536 [ INFO]:epggrab: module xmltv created 2016-11-15 18:58:56.539 [ INFO]:epgdb: gzip format detected, inflating (ratio 12.8% deflated size 110804) 2016-11-15 18:58:56.543 [ INFO]:epgdb: parsing 864579 bytes 2016-11-15 18:58:56.586 [ INFO]:epgdb: loaded v2 2016-11-15 18:58:56.586 [ INFO]:epgdb: config 1 2016-11-15 18:58:56.586 [ INFO]:epgdb: brands 0 2016-11-15 18:58:56.586 [ INFO]:epgdb: seasons 348 2016-11-15 18:58:56.586 [ INFO]:epgdb: episodes 1335 2016-11-15 18:58:56.586 [ INFO]:epgdb: broadcasts 1474 2016-11-15 18:58:56.588 [ NOTICE]:START: HTS Tvheadend version 4.1-2322~g879d532 started, running as PID:10377 UID:105 GID:44, CWD:/ CNF:/home/hts/.hts/tvheadend 2016-11-15 18:58:56.764 [ NOTICE]:linuxdvb: CAM slot 0 status changed to module present 2016-11-15 18:58:56.790 [ INFO]:scanfile: DVB-S - loaded 1 regions with 112 networks 2016-11-15 18:58:56.790 [ INFO]:scanfile: DVB-T - loaded 43 regions with 1106 networks 2016-11-15 18:58:56.790 [ INFO]:scanfile: DVB-C - loaded 17 regions with 56 networks 2016-11-15 18:58:56.790 [ INFO]:scanfile: ATSC-T - loaded 2 regions with 9 networks 2016-11-15 18:58:56.790 [ INFO]:scanfile: ATSC-C - loaded 1 regions with 5 networks 2016-11-15 18:58:56.790 [ INFO]:scanfile: ISDB-T - loaded 2 regions with 1297 networks 2016-11-15 18:58:57.515 [ INFO]:mpegts: 570MHz in Teracom - tuning on TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0 2016-11-15 18:59:00.411 [ INFO]:subscription: 0001: "epggrab" subscribing to mux "570MHz", weight: 4, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription" 2016-11-15 18:59:00.411 [ NOTICE]:linuxdvb: CAM slot 0 status changed to module ready 2016-11-15 18:59:00.494 [ TRACE]:en50221: 0x00000000 session 1 tc connect 2016-11-15 18:59:00.695 [ TRACE]:en50221: 0x00010041 session 1 connecting 2016-11-15 18:59:00.696 [ TRACE]:en50221: 0x00010041 session 1 connected 2016-11-15 18:59:01.100 [ TRACE]:en50221: rm reply cb received for slot 0, count 0 2016-11-15 18:59:01.408 [ TRACE]:en50221: rm enq callback received for slot 0 2016-11-15 18:59:01.712 [ TRACE]:en50221: 0x00020043 session 2 connecting 2016-11-15 18:59:01.712 [ TRACE]:en50221: 0x00020043 session 2 connected 2016-11-15 18:59:01.712 [ INFO]:en50221: setting CI+ CAM data rate to 72 Mbps 2016-11-15 18:59:01.974 [WARNING]:linuxdvb: TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0 - poll TIMEOUT 2016-11-15 18:59:02.121 [ INFO]:en50221: CAM slot 0: Application type: 01, manufacturer: cafe, Manufacturer code: babe 2016-11-15 18:59:02.121 [ INFO]:en50221: CAM slot 0: Menu string: Viaccess Access 2016-11-15 18:59:07.124 [ TRACE]:en50221: 0x00240041 session 3 connecting 2016-11-15 18:59:07.124 [ TRACE]:en50221: 0x00240041 session 3 connected 2016-11-15 18:59:07.429 [ TRACE]:en50221: datetime enquiry cb received for slot 0 2016-11-15 18:59:07.732 [ TRACE]:en50221: 0x00240041 session 3 close 2016-11-15 18:59:07.934 [ TRACE]:en50221: 0x00030041 session 3 connecting 2016-11-15 18:59:07.934 [ TRACE]:en50221: 0x00030041 session 3 connected 2016-11-15 18:59:08.339 [ TRACE]:dvbcam: unregister cam lca 0x7faca6aefdb0 slot 0 2016-11-15 18:59:08.340 [ TRACE]:dvbcam: register cam ca 0x7faca6aefdb0 slot 0 num_caids 2 2016-11-15 18:59:08.340 [ INFO]:en50221: CAM slot 0 supported CAIDs: 0500 (Viaccess) 0502 (Viaccess)
Files
History
Updated by Jaroslav Kysela almost 8 years ago
Updated by https://tvheadend.org/projects/tvheadend/wiki/Debugging - provide the backtrace of the crash...
Updated by Bengt Madeberg almost 8 years ago
Updated by Well, it seems that I have som issues to do the backtrace.
GNU gdb (Ubuntu 7.7.1-0ubuntu5~14.04.2) 7.7.1
Copyright (C) 2014 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
<http://www.gnu.org/software/gdb/documentation/>.
For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /usr/bin/tvheadend...done.
"/home/muy/_usr_bin_tvheadend.105.crash" is not a core dump: File format not recognized
(gdb)
Updated by Mark Clarkstone almost 8 years ago
Updated by Bengt Madeberg wrote:
Well, it seems that I have som issues to do the backtrace.
GNU gdb (Ubuntu 7.7.1-0ubuntu5~14.04.2) 7.7.1
Copyright (C) 2014 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
<http://www.gnu.org/software/gdb/documentation/>.
For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /usr/bin/tvheadend...done.
"/home/muy/_usr_bin_tvheadend.105.crash" is not a core dump: File format not recognized
(gdb)
The file attached is a ubuntu Apport log & not a core dump but it does contain (base64 encoded) one. Some info on debugging can be found here: https://wiki.ubuntu.com/DebuggingProgramCrash
If you're still stuck disable Apport and install corekeeper (dumps are in /var/crash).
Updated by Jaroslav Kysela almost 8 years ago
Just run tvheadend from command line but add 'gdb --args ' before the standard command line text. Then type 'r' (run) and wait for the crash. Then type 'bt' (backtrace).
Updated by Bengt Madeberg almost 8 years ago
Ok, thanks. I hope I got it right. 'bt' in the end...
hts@server3:~$ gdb --args /usr/bin/tvheadend -l /tmp/tvh.log --trace en50221,dvbcam GNU gdb (Ubuntu 7.7.1-0ubuntu5~14.04.2) 7.7.1 Copyright (C) 2014 Free Software Foundation, Inc. License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html> This is free software: you are free to change and redistribute it. There is NO WARRANTY, to the extent permitted by law. Type "show copying" and "show warranty" for details. This GDB was configured as "x86_64-linux-gnu". Type "show configuration" for configuration details. For bug reporting instructions, please see: <http://www.gnu.org/software/gdb/bugs/>. Find the GDB manual and other documentation resources online at: <http://www.gnu.org/software/gdb/documentation/>. For help, type "help". Type "apropos word" to search for commands related to "word"... Reading symbols from /usr/bin/tvheadend...done. (gdb) r Starting program: /usr/bin/tvheadend -l /tmp/tvh.log --trace en50221,dvbcam [Thread debugging using libthread_db enabled] Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1". [New Thread 0x7ffff5204700 (LWP 29457)] 2016-11-16 16:09:53.262 [ INFO] main: Log started 2016-11-16 16:09:53.262 [ INFO] http: Starting HTTP server 0.0.0.0:9981 2016-11-16 16:09:53.262 [ INFO] htsp: Starting HTSP server 0.0.0.0:9982 2016-11-16 16:09:53.262 [ ERROR] satips: use --satip_bindaddr parameter to select the local IP for SAT>IP 2016-11-16 16:09:53.262 [ ERROR] satips: using Google lookup (might block the task until timeout) 2016-11-16 16:09:53.277 [ INFO] satips: Starting SAT>IP RTSP server 192.168.0.93:9983 2016-11-16 16:09:53.277 [ INFO] satips: SAT>IP Server initialized 2016-11-16 16:09:53.277 [ INFO] satips: HTTP 192.168.0.93:9981, RTSP 192.168.0.93:9983 2016-11-16 16:09:53.277 [ INFO] satips: descramble 3, muxcnf 0 2016-11-16 16:09:53.277 [ INFO] satips: tuner[fe=1]: DVB-T2 #1 [New Thread 0x7ffff4a03700 (LWP 29458)] [New Thread 0x7ffff4202700 (LWP 29459)] [New Thread 0x7ffff3a01700 (LWP 29460)] 2016-11-16 16:09:53.542 [ INFO] config: loaded [New Thread 0x7ffff3200700 (LWP 29461)] [New Thread 0x7ffff29ff700 (LWP 29462)] 2016-11-16 16:09:53.549 [ INFO] config: scanfile (re)initialization with path <none> [New Thread 0x7ffff21fe700 (LWP 29463)] [New Thread 0x7ffff19fd700 (LWP 29464)] [New Thread 0x7ffff11fc700 (LWP 29465)] [New Thread 0x7ffff09fb700 (LWP 29466)] [New Thread 0x7fffe3fff700 (LWP 29467)] 2016-11-16 16:09:53.876 [ INFO] scanfile: DVB-S - loaded 1 regions with 112 networks 2016-11-16 16:09:53.876 [ INFO] scanfile: DVB-T - loaded 43 regions with 1106 networks 2016-11-16 16:09:53.876 [ INFO] scanfile: DVB-C - loaded 17 regions with 56 networks 2016-11-16 16:09:53.876 [ INFO] scanfile: ATSC-T - loaded 2 regions with 9 networks 2016-11-16 16:09:53.876 [ INFO] scanfile: ATSC-C - loaded 1 regions with 5 networks 2016-11-16 16:09:53.877 [ INFO] scanfile: ISDB-T - loaded 2 regions with 1297 networks [New Thread 0x7fffe37fe700 (LWP 29470)] [New Thread 0x7fffe2ffd700 (LWP 29471)] 2016-11-16 16:09:55.586 [ INFO] dvr: Creating new configuration '' [New Thread 0x7fffe27fc700 (LWP 29472)] [New Thread 0x7fffe1ffb700 (LWP 29473)] [New Thread 0x7fffe17fa700 (LWP 29474)] 2016-11-16 16:09:55.592 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call [New Thread 0x7fffe0ff9700 (LWP 29475)] 2016-11-16 16:09:55.594 [ INFO] csa: Using SSE2 128bit parallel descrambling 2016-11-16 16:09:55.594 [ INFO] descrambler: adding CAID 2600 as constant crypto-word (BISS) 2016-11-16 16:09:55.594 [ INFO] epggrab: module eit created 2016-11-16 16:09:55.594 [ INFO] epggrab: module uk_freesat created 2016-11-16 16:09:55.595 [ INFO] epggrab: module uk_freeview created 2016-11-16 16:09:55.595 [ INFO] epggrab: module viasat_baltic created 2016-11-16 16:09:55.595 [ INFO] epggrab: module Bulsatcom_39E created 2016-11-16 16:09:55.595 [ INFO] epggrab: module psip created 2016-11-16 16:09:55.604 [ INFO] epggrab: module opentv-skyit created 2016-11-16 16:09:55.606 [ INFO] epggrab: module opentv-skynz created 2016-11-16 16:09:55.606 [ INFO] epggrab: module opentv-ausat created 2016-11-16 16:09:55.606 [ INFO] epggrab: module opentv-skyuk created 2016-11-16 16:09:55.608 [ INFO] epggrab: module pyepg created 2016-11-16 16:09:55.608 [ INFO] epggrab: module xmltv created [New Thread 0x7fffd3fff700 (LWP 29477)] 2016-11-16 16:09:55.613 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call 2016-11-16 16:09:55.613 [ INFO] epgdb: gzip format detected, inflating (ratio 13.2% deflated size 117304) 2016-11-16 16:09:55.618 [ INFO] epgdb: parsing 886343 bytes 2016-11-16 16:09:55.675 [ INFO] epgdb: loaded v2 [New Thread 0x7fffd37fe700 (LWP 29478)] 2016-11-16 16:09:55.675 [ INFO] epgdb: config 1 2016-11-16 16:09:55.675 [ INFO] epgdb: brands 0 2016-11-16 16:09:55.675 [ INFO] epgdb: seasons 365 2016-11-16 16:09:55.675 [ INFO] epgdb: episodes 1382 2016-11-16 16:09:55.675 [ INFO] epgdb: broadcasts 1734 2016-11-16 16:09:55.677 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call [New Thread 0x7fffd2ffd700 (LWP 29479)] [New Thread 0x7fffd27fc700 (LWP 29480)] 2016-11-16 16:09:55.682 [ NOTICE] START: HTS Tvheadend version 4.1-2322~g879d532 started, running as PID:29453 UID:105 GID:112, CWD:/home/hts CNF:/home/hts/.hts/tvheadend [New Thread 0x7fffd1ffb700 (LWP 29482)] [New Thread 0x7fffd17fa700 (LWP 29481)] 2016-11-16 16:09:55.686 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call [New Thread 0x7fffd0ff9700 (LWP 29483)] 2016-11-16 16:09:55.688 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call [New Thread 0x7fffc7fff700 (LWP 29484)] 2016-11-16 16:09:55.691 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call [Thread 0x7fffd1ffb700 (LWP 29482) exited] [New Thread 0x7fffd1ffb700 (LWP 29498)] [New Thread 0x7fffc77fe700 (LWP 29499)] 2016-11-16 16:10:08.663 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call 2016-11-16 16:10:10.664 [ NOTICE] subscription: 0002: No input source available for subscription "SAT>IP" to mux "570MHz in Teracom" 2016-11-16 16:10:10.664 [ NOTICE] subscription: 0003: No input source available for subscription "SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" to service "Teracom/570MHz/TV4 HD Göteborg" in mux "570MHz in Teracom" 2016-11-16 16:10:12.664 [ NOTICE] subscription: 0002: No input source available for subscription "SAT>IP" to mux "570MHz in Teracom" 2016-11-16 16:10:12.664 [ NOTICE] subscription: 0003: No input source available for subscription "SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" to service "Teracom/570MHz/TV4 HD Göteborg" in mux "570MHz in Teracom" 2016-11-16 16:10:14.664 [ NOTICE] subscription: 0002: No input source available for subscription "SAT>IP" to mux "570MHz in Teracom" 2016-11-16 16:10:14.664 [ NOTICE] subscription: 0003: No input source available for subscription "SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" to service "Teracom/570MHz/TV4 HD Göteborg" in mux "570MHz in Teracom" 2016-11-16 16:10:14.711 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call [Thread 0x7fffc77fe700 (LWP 29499) exited] 2016-11-16 16:10:14.712 [ INFO] subscription: 0003: "SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" unsubscribing, client="SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" 2016-11-16 16:10:14.712 [ INFO] subscription: 0002: "SAT>IP" unsubscribing, hostname="192.168.0.180" [Thread 0x7fffd1ffb700 (LWP 29498) exited] ^C Program received signal SIGINT, Interrupt. pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:238 238 ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S: No such file or directory. (gdb) bt #0 pthread_cond_timedwait@@GLIBC_2.3.2 () at ../nptl/sysdeps/unix/sysv/linux/x86_64/pthread_cond_timedwait.S:238 #1 0x00005555556e5497 in mainloop () at src/main.c:715 #2 main (argc=<optimized out>, argv=<optimized out>) at src/main.c:1286
Updated by Jaroslav Kysela almost 8 years ago
The only problem is that tvh didn't crash in the session above :-(
Updated by Bengt Madeberg almost 8 years ago
Ok, I did some mistakes in the startup...ok now
muy@server3:~$ sudo gdb --args /usr/bin/tvheadend -u hts -g video
GNU gdb (Ubuntu 7.7.1-0ubuntu5~14.04.2) 7.7.1
Copyright (C) 2014 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
<http://www.gnu.org/software/gdb/documentation/>.
For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /usr/bin/tvheadend...done.
(gdb) r
Starting program: /usr/bin/tvheadend -u hts -g video
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
[New Thread 0x7ffff49c9700 (LWP 30715)]
2016-11-16 16:25:37.698 [ INFO] main: Log started
2016-11-16 16:25:37.741 [ INFO] http: Starting HTTP server 0.0.0.0:9981
2016-11-16 16:25:37.742 [ INFO] htsp: Starting HTSP server 0.0.0.0:9982
2016-11-16 16:25:37.742 [ ERROR] satips: use --satip_bindaddr parameter to select the local IP for SAT>IP
2016-11-16 16:25:37.742 [ ERROR] satips: using Google lookup (might block the task until timeout)
2016-11-16 16:25:37.758 [ INFO] satips: Starting SAT>IP RTSP server 192.168.0.93:9983
2016-11-16 16:25:37.758 [ INFO] satips: SAT>IP Server initialized
2016-11-16 16:25:37.758 [ INFO] satips: HTTP 192.168.0.93:9981, RTSP 192.168.0.93:9983
2016-11-16 16:25:37.758 [ INFO] satips: descramble 3, muxcnf 0
2016-11-16 16:25:37.758 [ INFO] satips: tuner[fe=1]: DVB-T2 #1
[New Thread 0x7ffff41c8700 (LWP 30717)]
[New Thread 0x7ffff39c7700 (LWP 30718)]
[New Thread 0x7ffff31c6700 (LWP 30719)]
2016-11-16 16:25:38.020 [ INFO] config: loaded
[New Thread 0x7ffff29c5700 (LWP 30720)]
[New Thread 0x7ffff21c4700 (LWP 30721)]
2016-11-16 16:25:38.024 [ INFO] config: scanfile (re)initialization with path <none>
[New Thread 0x7ffff19c3700 (LWP 30722)]
[New Thread 0x7ffff11c2700 (LWP 30723)]
[New Thread 0x7ffff09c1700 (LWP 30724)]
[New Thread 0x7fffe3fff700 (LWP 30725)]
[New Thread 0x7fffe37fe700 (LWP 30726)]
2016-11-16 16:25:38.046 [ INFO] linuxdvb: adapter added /dev/dvb/adapter0
[New Thread 0x7fffe2ffd700 (LWP 30728)]
[New Thread 0x7fffe27fc700 (LWP 30729)]
2016-11-16 16:25:38.055 [ INFO] dvr: Creating new configuration ''
[New Thread 0x7fffe1ffb700 (LWP 30730)]
[New Thread 0x7fffe17fa700 (LWP 30731)]
[New Thread 0x7fffe0ff9700 (LWP 30732)]
[New Thread 0x7fffd3fff700 (LWP 30733)]
2016-11-16 16:25:38.066 [ INFO] csa: Using SSE2 128bit parallel descrambling
2016-11-16 16:25:38.066 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 16:25:38.067 [ INFO] descrambler: adding CAID 2600 as constant crypto-word (BISS)
2016-11-16 16:25:38.067 [ INFO] epggrab: module eit created
2016-11-16 16:25:38.067 [ INFO] epggrab: module uk_freesat created
2016-11-16 16:25:38.067 [ INFO] epggrab: module uk_freeview created
2016-11-16 16:25:38.067 [ INFO] epggrab: module viasat_baltic created
2016-11-16 16:25:38.067 [ INFO] epggrab: module Bulsatcom_39E created
2016-11-16 16:25:38.067 [ INFO] epggrab: module psip created
2016-11-16 16:25:38.074 [ INFO] epggrab: module opentv-skyit created
2016-11-16 16:25:38.076 [ INFO] epggrab: module opentv-skynz created
2016-11-16 16:25:38.076 [ INFO] epggrab: module opentv-ausat created
2016-11-16 16:25:38.076 [ INFO] epggrab: module opentv-skyuk created
2016-11-16 16:25:38.078 [ INFO] epggrab: module pyepg created
2016-11-16 16:25:38.078 [ INFO] epggrab: module xmltv created
[New Thread 0x7fffd37fe700 (LWP 30734)]
2016-11-16 16:25:38.082 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 16:25:38.086 [ INFO] epgdb: gzip format detected, inflating (ratio 13.3% deflated size 117270)
2016-11-16 16:25:38.092 [ INFO] epgdb: parsing 883940 bytes
2016-11-16 16:25:38.144 [ INFO] epgdb: loaded v2
2016-11-16 16:25:38.145 [ INFO] epgdb: config 1
2016-11-16 16:25:38.145 [ INFO] epgdb: brands 0
2016-11-16 16:25:38.145 [ INFO] epgdb: seasons 363
2016-11-16 16:25:38.145 [ INFO] epgdb: episodes 1379
2016-11-16 16:25:38.145 [ INFO] epgdb: broadcasts 1738
[New Thread 0x7fffd2ffd700 (LWP 30735)]
2016-11-16 16:25:38.148 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffd27fc700 (LWP 30736)]
2016-11-16 16:25:38.149 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffd1ffb700 (LWP 30737)]
2016-11-16 16:25:38.151 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 16:25:38.153 [ NOTICE] START: HTS Tvheadend version 4.1-2322~g879d532 started, running as PID:30711 UID:105 GID:44, CWD:/home/muy CNF:/home/hts/.hts/tvheadend
[New Thread 0x7fffd17fa700 (LWP 30738)]
2016-11-16 16:25:38.155 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffd0ff9700 (LWP 30739)]
2016-11-16 16:25:38.157 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffc3fff700 (LWP 30740)]
2016-11-16 16:25:38.160 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffc37fe700 (LWP 30741)]
2016-11-16 16:25:38.162 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffc2ffd700 (LWP 30742)]
2016-11-16 16:25:38.164 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 16:25:38.272 [ NOTICE] linuxdvb: CAM slot 0 status changed to module present
2016-11-16 16:25:38.388 [ INFO] scanfile: DVB-S - loaded 1 regions with 112 networks
2016-11-16 16:25:38.388 [ INFO] scanfile: DVB-T - loaded 43 regions with 1106 networks
2016-11-16 16:25:38.388 [ INFO] scanfile: DVB-C - loaded 17 regions with 56 networks
2016-11-16 16:25:38.388 [ INFO] scanfile: ATSC-T - loaded 2 regions with 9 networks
2016-11-16 16:25:38.388 [ INFO] scanfile: ATSC-C - loaded 1 regions with 5 networks
2016-11-16 16:25:38.388 [ INFO] scanfile: ISDB-T - loaded 2 regions with 1297 networks
[New Thread 0x7fffc27fc700 (LWP 30743)]
[Thread 0x7fffc27fc700 (LWP 30743) exited]
2016-11-16 16:25:39.023 [ INFO] mpegts: 570MHz in Teracom - tuning on TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0
2016-11-16 16:25:41.687 [ INFO] subscription: 0001: "epggrab" subscribing to mux "570MHz", weight: 4, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription"
2016-11-16 16:25:41.687 [ NOTICE] linuxdvb: CAM slot 0 status changed to module ready
[New Thread 0x7fffc27fc700 (LWP 30747)]
2016-11-16 16:25:41.692 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffc1ffb700 (LWP 30749)]
2016-11-16 16:25:42.360 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 16:25:42.935 [ INFO] en50221: setting CI+ CAM data rate to 72 Mbps
2016-11-16 16:25:43.254 [WARNING] linuxdvb: TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0 - poll TIMEOUT
2016-11-16 16:25:43.345 [ INFO] en50221: CAM slot 0: Application type: 01, manufacturer: cafe, Manufacturer code: babe
2016-11-16 16:25:43.345 [ INFO] en50221: CAM slot 0: Menu string: Viaccess Access
[New Thread 0x7fffc17fa700 (LWP 30756)]
2016-11-16 16:25:48.004 [ INFO] subscription: 0002: "SAT>IP" subscribing to mux "570MHz", weight: 150, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription", hostname="192.168.0.180"
[New Thread 0x7fffc0ff9700 (LWP 30757)]
2016-11-16 16:25:48.009 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 16:25:49.565 [ INFO] en50221: CAM slot 0 supported CAIDs: 0500 (Viaccess) 0502 (Viaccess)
2016-11-16 16:25:53.356 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[Thread 0x7fffc0ff9700 (LWP 30757) exited]
2016-11-16 16:25:53.357 [ INFO] subscription: 0002: "SAT>IP" unsubscribing, hostname="192.168.0.180"
[New Thread 0x7fffc0ff9700 (LWP 30763)]
2016-11-16 16:25:53.362 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 16:25:53.363 [ INFO] subscription: 0003: "SAT>IP" subscribing to mux "570MHz", weight: 150, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription", hostname="192.168.0.180"
2016-11-16 16:25:53.363 [ INFO] subscription: 0004: "SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" subscribing to service "Teracom/570MHz/TV4 HD Göteborg", weight: 100, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", mux: "570MHz", provider: "TV4 AB", client="SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg"
Program received signal SIGSEGV, Segmentation fault.
[Switching to Thread 0x7fffc3fff700 (LWP 30740)]
ts_recv_skipped0 (len=<optimized out>, tsb=<optimized out>, st=<optimized out>, t=<optimized out>) at src/input/mpegts/tsdemux.c:167
167 if (mpegts_pid_rexists(t->s_slaves_pids, pid))
(gdb) bt
#0 ts_recv_skipped0 (len=<optimized out>, tsb=<optimized out>, st=<optimized out>, t=<optimized out>) at src/input/mpegts/tsdemux.c:167
#1 ts_skip_packet2 (t=0x555556b25300,
tsb=tsb@entry=0x7fffb4008ead "G\031ۖ%\215\061\030\356\232L\250ۘ\a\223\256\037\253\231\036-\032\065\033\342gA\225Mspx\v\247\036\370\204\260\357D\"y`W\224\365,\320Q#S\227\017\371\211y\333W\376?a\320?\030\325,\270\065W\243\246M\345\345\026\355vLE'\021\036\037\326ޣM\216L\340WcZ\343\032\301\366?\226\322\351\204\346\272\345\323\001\351\023\262\215\206* W\347t0\351g\367\224\304iA\357hL\001Ӈ&\t\036\224\246\350'\317\302\212\276\247\020\326v\262\322\335", <incomplete sequence \355>, len=len@entry=1128) at src/input/mpegts/tsdemux.c:284
#2 0x00005555557908d9 in descrambler_descramble (t=t@entry=0x555556b25300, st=st@entry=0x555556b25760,
tsb=tsb@entry=0x7fffb4008ead "G\031ۖ%\215\061\030\356\232L\250ۘ\a\223\256\037\253\231\036-\032\065\033\342gA\225Mspx\v\247\036\370\204\260\357D\"y`W\224\365,\320Q#S\227\017\371\211y\333W\376?a\320?\030\325,\270\065W\243\246M\345\345\026\355vLE'\021\036\037\326ޣM\216L\340WcZ\343\032\301\366?\226\322\351\204\346\272\345\323\001\351\023\262\215\206* W\347t0\351g\367\224\304iA\357hL\001Ӈ&\t\036\224\246\350'\317\302\212\276\247\020\326v\262\322\335", <incomplete sequence \355>, len=len@entry=1128) at src/descrambler/descrambler.c:842
#3 0x0000555555798ba5 in ts_recv_packet1 (t=0x555556b25300,
tsb=tsb@entry=0x7fffb4008ead "G\031ۖ%\215\061\030\356\232L\250ۘ\a\223\256\037\253\231\036-\032\065\033\342gA\225Mspx\v\247\036\370\204\260\357D\"y`W\224\365,\320Q#S\227\017\371\211y\333W\376?a\320?\030\325,\270\065W\243\246M\345\345\026\355vLE'\021\036\037\326ޣM\216L\340WcZ\343\032\301\366?\226\322\351\204\346\272\345\323\001\351\023\262\215\206* W\347t0\351g\367\224\304iA\357hL\001Ӈ&\t\036\224\246\350'\317\302\212\276\247\020\326v\262\322\335", <incomplete sequence \355>, len=len@entry=1128, table=1) at src/input/mpegts/tsdemux.c:232
#4 0x000055555579678e in mpegts_input_process (mpkt=<optimized out>, mi=<optimized out>) at src/input/mpegts/mpegts_input.c:1365
#5 mpegts_input_thread (p=<optimized out>) at src/input/mpegts/mpegts_input.c:1506
#6 0x00005555556f20b2 in thread_wrapper (p=0x7fffc8000a30) at src/wrappers.c:159
#7 0x00007ffff62c3184 in start_thread (arg=0x7fffc3fff700) at pthread_create.c:312
#8 0x00007ffff57de37d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:111
(gdb)
Updated by Jaroslav Kysela almost 8 years ago
Could you compile tvh binary with --enable-ccdebug and provide another backtrace like this one ?
Updated by Bengt Madeberg almost 8 years ago
Hop I got it ok ? I changed in the configre file and did a new autobild.
muy@server3:~$ sudo gdb --args /usr/bin/tvheadend -u hts -g video
GNU gdb (Ubuntu 7.7.1-0ubuntu5~14.04.2) 7.7.1
Copyright (C) 2014 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
<http://www.gnu.org/software/gdb/documentation/>.
For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /usr/bin/tvheadend...done.
(gdb) r
Starting program: /usr/bin/tvheadend -u hts -g video
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
[New Thread 0x7ffff49c9700 (LWP 7404)]
2016-11-16 17:15:17.529 [ INFO] main: Log started
2016-11-16 17:15:17.572 [ INFO] http: Starting HTTP server 0.0.0.0:9981
2016-11-16 17:15:17.572 [ INFO] htsp: Starting HTSP server 0.0.0.0:9982
2016-11-16 17:15:17.572 [ ERROR] satips: use --satip_bindaddr parameter to select the local IP for SAT>IP
2016-11-16 17:15:17.572 [ ERROR] satips: using Google lookup (might block the task until timeout)
2016-11-16 17:15:17.589 [ INFO] satips: Starting SAT>IP RTSP server 192.168.0.93:9983
2016-11-16 17:15:17.589 [ INFO] satips: SAT>IP Server initialized
2016-11-16 17:15:17.589 [ INFO] satips: HTTP 192.168.0.93:9981, RTSP 192.168.0.93:9983
2016-11-16 17:15:17.589 [ INFO] satips: descramble 3, muxcnf 0
2016-11-16 17:15:17.589 [ INFO] satips: tuner[fe=1]: DVB-T2 #1
[New Thread 0x7ffff41c8700 (LWP 7405)]
[New Thread 0x7ffff39c7700 (LWP 7406)]
[New Thread 0x7ffff31c6700 (LWP 7407)]
2016-11-16 17:15:17.838 [ INFO] config: loaded
[New Thread 0x7ffff29c5700 (LWP 7408)]
[New Thread 0x7ffff21c4700 (LWP 7409)]
2016-11-16 17:15:17.842 [ INFO] config: scanfile (re)initialization with path <none>
[New Thread 0x7ffff19c3700 (LWP 7410)]
[New Thread 0x7ffff11c2700 (LWP 7411)]
[New Thread 0x7ffff09c1700 (LWP 7412)]
[New Thread 0x7fffe3fff700 (LWP 7413)]
[New Thread 0x7fffe37fe700 (LWP 7414)]
2016-11-16 17:15:17.865 [ INFO] linuxdvb: adapter added /dev/dvb/adapter0
[New Thread 0x7fffe2ffd700 (LWP 7415)]
[New Thread 0x7fffe27fc700 (LWP 7416)]
2016-11-16 17:15:17.875 [ INFO] dvr: Creating new configuration ''
[New Thread 0x7fffe1ffb700 (LWP 7417)]
[New Thread 0x7fffe17fa700 (LWP 7418)]
[New Thread 0x7fffe0ff9700 (LWP 7419)]
2016-11-16 17:15:17.884 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffd3fff700 (LWP 7420)]
2016-11-16 17:15:17.887 [ INFO] csa: Using SSE2 128bit parallel descrambling
2016-11-16 17:15:17.887 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 17:15:17.887 [ INFO] descrambler: adding CAID 2600 as constant crypto-word (BISS)
2016-11-16 17:15:17.887 [ INFO] epggrab: module eit created
2016-11-16 17:15:17.887 [ INFO] epggrab: module uk_freesat created
2016-11-16 17:15:17.887 [ INFO] epggrab: module uk_freeview created
2016-11-16 17:15:17.887 [ INFO] epggrab: module viasat_baltic created
2016-11-16 17:15:17.887 [ INFO] epggrab: module Bulsatcom_39E created
2016-11-16 17:15:17.887 [ INFO] epggrab: module psip created
2016-11-16 17:15:17.897 [ INFO] epggrab: module opentv-skyit created
2016-11-16 17:15:17.899 [ INFO] epggrab: module opentv-skynz created
2016-11-16 17:15:17.900 [ INFO] epggrab: module opentv-ausat created
2016-11-16 17:15:17.900 [ INFO] epggrab: module opentv-skyuk created
2016-11-16 17:15:17.902 [ INFO] epggrab: module pyepg created
2016-11-16 17:15:17.902 [ INFO] epggrab: module xmltv created
[New Thread 0x7fffd37fe700 (LWP 7421)]
2016-11-16 17:15:17.906 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 17:15:17.906 [ INFO] epgdb: gzip format detected, inflating (ratio 13.1% deflated size 116160)
2016-11-16 17:15:17.912 [ INFO] epgdb: parsing 888921 bytes
2016-11-16 17:15:17.986 [ INFO] epgdb: loaded v2
2016-11-16 17:15:17.987 [ INFO] epgdb: config 1
2016-11-16 17:15:17.987 [ INFO] epgdb: brands 0
2016-11-16 17:15:17.987 [ INFO] epgdb: seasons 365
2016-11-16 17:15:17.987 [ INFO] epgdb: episodes 1399
2016-11-16 17:15:17.987 [ INFO] epgdb: broadcasts 1754
[New Thread 0x7fffd2ffd700 (LWP 7422)]
2016-11-16 17:15:17.991 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffd27fc700 (LWP 7423)]
2016-11-16 17:15:17.993 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffd1ffb700 (LWP 7424)]
2016-11-16 17:15:17.995 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 17:15:17.997 [ NOTICE] START: HTS Tvheadend version 4.1-2322~g879d532-dirty started, running as PID:7399 UID:105 GID:44, CWD:/home/muy CNF:/home/hts/.hts/tvheadend
[New Thread 0x7fffd17fa700 (LWP 7425)]
2016-11-16 17:15:17.999 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffd0ff9700 (LWP 7426)]
2016-11-16 17:15:18.002 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffc3fff700 (LWP 7427)]
2016-11-16 17:15:18.004 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffc37fe700 (LWP 7428)]
2016-11-16 17:15:18.007 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffc2ffd700 (LWP 7429)]
2016-11-16 17:15:18.009 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 17:15:18.090 [ NOTICE] linuxdvb: CAM slot 0 status changed to module present
2016-11-16 17:15:18.313 [ INFO] scanfile: DVB-S - loaded 1 regions with 112 networks
2016-11-16 17:15:18.313 [ INFO] scanfile: DVB-T - loaded 43 regions with 1106 networks
2016-11-16 17:15:18.313 [ INFO] scanfile: DVB-C - loaded 17 regions with 56 networks
2016-11-16 17:15:18.313 [ INFO] scanfile: ATSC-T - loaded 2 regions with 9 networks
2016-11-16 17:15:18.313 [ INFO] scanfile: ATSC-C - loaded 1 regions with 5 networks
2016-11-16 17:15:18.313 [ INFO] scanfile: ISDB-T - loaded 2 regions with 1297 networks
2016-11-16 17:15:18.841 [ INFO] mpegts: 570MHz in Teracom - tuning on TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0
2016-11-16 17:15:21.303 [ INFO] subscription: 0001: "epggrab" subscribing to mux "570MHz", weight: 4, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription"
2016-11-16 17:15:21.303 [ NOTICE] linuxdvb: CAM slot 0 status changed to module ready
[New Thread 0x7fffc27fc700 (LWP 7434)]
2016-11-16 17:15:21.309 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
[New Thread 0x7fffc1ffb700 (LWP 7435)]
[New Thread 0x7fffc17fa700 (LWP 7436)]
2016-11-16 17:15:22.126 [ INFO] subscription: 0002: "SAT>IP" subscribing to mux "570MHz", weight: 150, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription", hostname="192.168.0.180"
[New Thread 0x7fffc0ff9700 (LWP 7437)]
2016-11-16 17:15:22.128 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 17:15:22.559 [ INFO] en50221: setting CI+ CAM data rate to 72 Mbps
2016-11-16 17:15:22.880 [WARNING] linuxdvb: TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0 - poll TIMEOUT
2016-11-16 17:15:22.969 [ INFO] en50221: CAM slot 0: Application type: 01, manufacturer: cafe, Manufacturer code: babe
2016-11-16 17:15:22.969 [ INFO] en50221: CAM slot 0: Menu string: Viaccess Access
2016-11-16 17:15:28.034 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 17:15:28.035 [ INFO] subscription: 0002: "SAT>IP" unsubscribing, hostname="192.168.0.180"
[Thread 0x7fffc0ff9700 (LWP 7437) exited]
[New Thread 0x7fffc0ff9700 (LWP 7444)]
2016-11-16 17:15:28.042 [ ERROR] tcp: tcp_server_loop: tvhpoll_wait: Interrupted system call
2016-11-16 17:15:28.043 [ INFO] subscription: 0003: "SAT>IP" subscribing to mux "570MHz", weight: 150, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription", hostname="192.168.0.180"
2016-11-16 17:15:28.043 [ INFO] subscription: 0004: "SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" subscribing to service "Teracom/570MHz/TV4 HD Göteborg", weight: 100, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", mux: "570MHz", provider: "TV4 AB", client="SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg"
Program received signal SIGSEGV, Segmentation fault.
[Switching to Thread 0x7fffc3fff700 (LWP 7427)]
0x00005555557ee273 in mpegts_pid_rexists (pids=0x0, pid=6619) at /home/muy/tvh_20161116/tvheadend/src/input/mpegts.h:111
111 { return pids->all || mpegts_pid_find_rindex(pids, pid) >= 0; }
(gdb) bt
#0 0x00005555557ee273 in mpegts_pid_rexists (pids=0x0, pid=6619) at /home/muy/tvh_20161116/tvheadend/src/input/mpegts.h:111
#1 0x00005555557ee884 in ts_recv_skipped0 (t=0x555556be5300, st=0x555556be5760,
tsb=0x7fffb40053ed "G\031\333\334U\250}It\372\372\213l\354\254fL;s\001F\217\251\333S\377֫\361U=W\311Eh7\303\067\032g\312\346u\354n\021\220/0(\025@>(\303?,ZV\351\024;\006N\265@t}\253\v!-\311\313_wE\\\260S\033\226hZ\240\373\301Yq\237vv\r\f~\036\301\202b1V \267<\345\355e\177o\205\212\f\376\377\303\023_\026\024\206Ƚ\342\211.ߕ~\"h\223\230\257\022\362\217,,\003\273\026\017$bj\377\304R\231\360\262\025\240\067\370\306\364\317X\245\262\222:x\244\273}\031\313q6\253\023\361\064-", <incomplete sequence \337>, len=1504) at src/input/mpegts/tsdemux.c:167
#2 0x00005555557eeca8 in ts_skip_packet2 (t=0x555556be5300,
tsb=0x7fffb40053ed "G\031\333\334U\250}It\372\372\213l\354\254fL;s\001F\217\251\333S\377֫\361U=W\311Eh7\303\067\032g\312\346u\354n\021\220/0(\025@>(\303?,ZV\351\024;\006N\265@t}\253\v!-\311\313_wE\\\260S\033\226hZ\240\373\301Yq\237vv\r\f~\036\301\202b1V \267<\345\355e\177o\205\212\f\376\377\303\023_\026\024\206Ƚ\342\211.ߕ~\"h\223\230\257\022\362\217,,\003\273\026\017$bj\377\304R\231\360\262\025\240\067\370\306\364\317X\245\262\222:x\244\273}\031\313q6\253\023\361\064-", <incomplete sequence \337>, len=1504) at src/input/mpegts/tsdemux.c:284
#3 0x00005555557e1516 in descrambler_descramble (t=0x555556be5300, st=0x555556be5760,
tsb=0x7fffb40053ed "G\031\333\334U\250}It\372\372\213l\354\254fL;s\001F\217\251\333S\377֫\361U=W\311Eh7\303\067\032g\312\346u\354n\021\220/0(\025@>(\303?,ZV\351\024;\006N\265@t}\253\v!-\311\313_wE\\\260S\033\226hZ\240\373\301Yq\237vv\r\f~\036\301\202b1V \267<\345\355e\177o\205\212\f\376\377\303\023_\026\024\206Ƚ\342\211.ߕ~\"h\223\230\257\022\362\217,,\003\273\026\017$bj\377\304R\231\360\262\025\240\067\370\306\364\317X\245\262\222:x\244\273}\031\313q6\253\023\361\064-", <incomplete sequence \337>, len=1504) at src/descrambler/descrambler.c:842
#4 0x00005555557eead8 in ts_recv_packet1 (t=0x555556be5300,
tsb=0x7fffb40053ed "G\031\333\334U\250}It\372\372\213l\354\254fL;s\001F\217\251\333S\377֫\361U=W\311Eh7\303\067\032g\312\346u\354n\021\220/0(\025@>(\303?,ZV\351\024;\006N\265@t}\253\v!-\311\313_wE\\\260S\033\226hZ\240\373\301Yq\237vv\r\f~\036\301\202b1V \267<\345\355e\177o\205\212\f\376\377\303\023_\026\024\206Ƚ\342\211.ߕ~\"h\223\230\257\022\362\217,,\003\273\026\017$bj\377\304R\231\360\262\025\240\067\370\306\364\317X\245\262\222:x\244\273}\031\313q6\253\023\361\064-", <incomplete sequence \337>, len=1504, table=1) at src/input/mpegts/tsdemux.c:232
#5 0x00005555557ebd08 in mpegts_input_process (mi=0x555556b85ed0, mpkt=0x7fffb4005310) at src/input/mpegts/mpegts_input.c:1365
#6 0x00005555557ec4ce in mpegts_input_thread (p=0x555556b85ed0) at src/input/mpegts/mpegts_input.c:1506
#7 0x00005555556fb67c in thread_wrapper (p=0x7fffc8000a30) at src/wrappers.c:159
#8 0x00007ffff62c3184 in start_thread (arg=0x7fffc3fff700) at pthread_create.c:312
#9 0x00007ffff57de37d in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:111
(gdb)
Updated by Jaroslav Kysela almost 8 years ago
- Status changed from New to Fixed
- % Done changed from 0 to 100
Applied in changeset commit:tvheadend|242bee1c7670c5f3fe56a8ae7e35950e38b6bcb9.
Updated by Bengt Madeberg almost 8 years ago
Great. Many thanks. The HW CAM implemenation has never worked better than now. When doing some experiments, I can se that even if my CAM support 2 channels which I have in the configuration there are still some issues. In 50 % av the cases the first channel stops (freezes) when selecting a new one. I will check without SAT>IP to se if there is any difference.
Below 2 channels streaming perfect
Her it looks like 2 channels are streaming but only one works. (lower bitrate)
It seems that unsubscribing is sent even if I have not ordered any unsubscription
2016-11-17 11:20:49.108 subscription: 1D59: "192.168.0.67 [ muy | Kodi Media Center ]" subscribing on channel "Kanal 5 HD", weight: 150, adapter: "SAT>IP DVB-T Tuner #1 (192.168.0.93:9983)", network: "Teracom_sat_ip", mux: "570MHz", provider: "SBS Broadcasting Networks Ltd", service: "Kanal 5 HD", profile="htsp", hostname="192.168.0.67", username="muy", client="Kodi Media Center"
2016-11-17 11:20:53.162 subscription: 1D59: "192.168.0.67 [ muy | Kodi Media Center ]" unsubscribing from "Kanal 5 HD", hostname="192.168.0.67", username="muy", client="Kodi Media Center"
2016-11-17 11:20:53.163 subscription: 1D5A: "192.168.0.67 [ muy | Kodi Media Center ]" subscribing on channel "TV3 HD GÖTEBORG", weight: 150, adapter: "SAT>IP DVB-T Tuner #1 (192.168.0.93:9983)", network: "Teracom_sat_ip", mux: "570MHz", provider: "Viasat AB", service: "TV3 HD GÖTEBORG", profile="htsp", hostname="192.168.0.67", username="muy", client="Kodi Media Center"
Updated by Bengt Madeberg almost 8 years ago
Have I also now noticed that when running via SAT>IP it seems to work reasonble good except the stuff above. If I connect directly the channels never shows up...The log below is when I first connect kodi directly and then I change to my other tvh server (SAT>IP client) inbetween.
2016-11-17 12:53:52.678 [ TRACE]:dvbcam: start service 0x7f942b9fc200 2016-11-17 12:53:54.245 [WARNING]:TS: Teracom/570MHz/TV4 HD Göteborg: H264 @ #6619 Continuity counter error (total 1) 2016-11-17 12:53:54.245 [WARNING]:TS: Teracom/570MHz/TV4 HD Göteborg: AAC @ #6618 Continuity counter error (total 1) 2016-11-17 12:53:54.601 [WARNING]:subscription: 0060: service instance is bad, reason: No access 2016-11-17 12:53:54.602 [ TRACE]:dvbcam: stop service 0x7f942b9fc200 2016-11-17 12:53:54.602 [ TRACE]:en50221: not_selected CAPMT enqueued (update) 2016-11-17 12:53:54.652 [ TRACE]:en50221: not_selected CAPMT sent (update) 2016-11-17 12:53:54.652 [ TRACE]:en50221: 05 19 D2 05 00 00 1B 19 DB 00 34 04 09 0F 05 00 ..........4..... 2016-11-17 12:53:54.652 [ TRACE]:en50221: E0 BC 10 01 00 13 01 20 14 03 04 0D 08 09 0F 05 ....... ........ 2016-11-17 12:53:54.652 [ TRACE]:en50221: 00 E0 41 10 01 00 13 01 20 14 03 02 05 08 09 0F ..A..... ....... 2016-11-17 12:53:54.652 [ TRACE]:en50221: 05 00 E0 42 10 01 00 13 01 20 14 03 02 32 08 11 ...B..... ...2.. 2016-11-17 12:53:54.652 [ TRACE]:en50221: 19 DA 00 34 04 09 0F 05 00 E0 BC 10 01 00 13 01 ...4............ 2016-11-17 12:53:54.652 [ TRACE]:en50221: 20 14 03 04 0D 08 09 0F 05 00 E0 41 10 01 00 13 ..........A.... 2016-11-17 12:53:54.652 [ TRACE]:en50221: 01 20 14 03 02 05 08 09 0F 05 00 E0 42 10 01 00 . ..........B... 2016-11-17 12:53:54.652 [ TRACE]:en50221: 13 01 20 14 03 02 32 08 06 04 16 00 00 .. ...2...... 2016-11-17 12:53:56.602 [ NOTICE]:subscription: 0060: No input source available for subscription "192.168.0.67 [ muy | Kodi Media Center ]" to channel "TV4 HD Göteborg" 2016-11-17 12:53:58.602 [ NOTICE]:subscription: 0060: No input source available for subscription "192.168.0.67 [ muy | Kodi Media Center ]" to channel "TV4 HD Göteborg" 2016-11-17 12:54:00.602 [ NOTICE]:subscription: 0060: No input source available for subscription "192.168.0.67 [ muy | Kodi Media Center ]" to channel "TV4 HD Göteborg" 2016-11-17 12:54:02.602 [ NOTICE]:subscription: 0060: No input source available for subscription "192.168.0.67 [ muy | Kodi Media Center ]" to channel "TV4 HD Göteborg" 2016-11-17 12:54:04.602 [ NOTICE]:subscription: 0060: No input source available for subscription "192.168.0.67 [ muy | Kodi Media Center ]" to channel "TV4 HD Göteborg" 2016-11-17 12:54:04.612 [ INFO]:subscription: 0060: "192.168.0.67 [ muy | Kodi Media Center ]" unsubscribing from "TV4 HD Göteborg", hostname="192.168.0.67", username="muy", client="Kodi Media Center" 2016-11-17 12:54:04.612 [ TRACE]:dvbcam: stop service 0x7f942b9fc200 2016-11-17 12:54:04.613 [ TRACE]:dvbcam: start service 0x7f942b9f7af0 2016-11-17 12:54:04.613 [ INFO]:subscription: 0061: "192.168.0.67 [ muy | Kodi Media Center ]" subscribing on channel "Kanal 5 HD", weight: 150, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", mux: "570MHz", provider: "SBS Broadcasting Networks Ltd", service: "Kanal 5 HD", profile="htsp", hostname="192.168.0.67", username="muy", client="Kodi Media Center" 2016-11-17 12:54:04.719 [ TRACE]:dvbcam: found active cam entry 2016-11-17 12:54:04.719 [ TRACE]:en50221: ok_descrambling CAPMT enqueued (only) 2016-11-17 12:54:04.720 [ TRACE]:dvbcam: start service 0x7f942b9f7af0 2016-11-17 12:54:04.740 [ TRACE]:en50221: ok_descrambling CAPMT sent (only) 2016-11-17 12:54:04.740 [ TRACE]:en50221: 03 0D 7A 05 00 00 1B 0D 83 00 34 01 09 0F 05 00 ..z.......4..... 2016-11-17 12:54:04.740 [ TRACE]:en50221: E0 BD 10 01 00 13 01 20 14 03 04 0D 08 09 0F 05 ....... ........ 2016-11-17 12:54:04.740 [ TRACE]:en50221: 00 E0 43 10 01 00 13 01 20 14 03 02 05 08 09 0F ..C..... ....... 2016-11-17 12:54:04.740 [ TRACE]:en50221: 05 00 E0 44 10 01 00 13 01 20 14 03 02 32 08 11 ...D..... ...2.. 2016-11-17 12:54:04.740 [ TRACE]:en50221: 0D 82 00 34 01 09 0F 05 00 E0 BD 10 01 00 13 01 ...4............ 2016-11-17 12:54:04.740 [ TRACE]:en50221: 20 14 03 04 0D 08 09 0F 05 00 E0 43 10 01 00 13 ..........C.... 2016-11-17 12:54:04.740 [ TRACE]:en50221: 01 20 14 03 02 05 08 09 0F 05 00 E0 44 10 01 00 . ..........D... 2016-11-17 12:54:04.740 [ TRACE]:en50221: 13 01 20 14 03 02 32 08 06 0D B2 00 00 .. ...2...... 2016-11-17 12:54:06.383 [WARNING]:TS: Teracom/570MHz/Kanal 5 HD: H264 @ #3459 Continuity counter error (total 1) 2016-11-17 12:54:06.400 [WARNING]:TS: Teracom/570MHz/Kanal 5 HD: AAC @ #3458 Continuity counter error (total 1) 2016-11-17 12:54:06.613 [WARNING]:subscription: 0061: service instance is bad, reason: No access 2016-11-17 12:54:06.613 [ TRACE]:dvbcam: stop service 0x7f942b9f7af0 2016-11-17 12:54:06.613 [ TRACE]:en50221: not_selected CAPMT enqueued (update) 2016-11-17 12:54:06.663 [ TRACE]:en50221: not_selected CAPMT sent (update) 2016-11-17 12:54:06.663 [ TRACE]:en50221: 05 0D 7A 05 00 00 1B 0D 83 00 34 04 09 0F 05 00 ..z.......4..... 2016-11-17 12:54:06.663 [ TRACE]:en50221: E0 BD 10 01 00 13 01 20 14 03 04 0D 08 09 0F 05 ....... ........ 2016-11-17 12:54:06.663 [ TRACE]:en50221: 00 E0 43 10 01 00 13 01 20 14 03 02 05 08 09 0F ..C..... ....... 2016-11-17 12:54:06.663 [ TRACE]:en50221: 05 00 E0 44 10 01 00 13 01 20 14 03 02 32 08 11 ...D..... ...2.. 2016-11-17 12:54:06.663 [ TRACE]:en50221: 0D 82 00 34 04 09 0F 05 00 E0 BD 10 01 00 13 01 ...4............ 2016-11-17 12:54:06.663 [ TRACE]:en50221: 20 14 03 04 0D 08 09 0F 05 00 E0 43 10 01 00 13 ..........C.... 2016-11-17 12:54:06.663 [ TRACE]:en50221: 01 20 14 03 02 05 08 09 0F 05 00 E0 44 10 01 00 . ..........D... 2016-11-17 12:54:06.663 [ TRACE]:en50221: 13 01 20 14 03 02 32 08 06 0D B2 00 00 .. ...2...... 2016-11-17 12:54:08.613 [ NOTICE]:subscription: 0061: No input source available for subscription "192.168.0.67 [ muy | Kodi Media Center ]" to channel "Kanal 5 HD" 2016-11-17 12:54:10.613 [ NOTICE]:subscription: 0061: No input source available for subscription "192.168.0.67 [ muy | Kodi Media Center ]" to channel "Kanal 5 HD" 2016-11-17 12:54:11.623 [ INFO]:subscription: 0061: "192.168.0.67 [ muy | Kodi Media Center ]" unsubscribing from "Kanal 5 HD", hostname="192.168.0.67", username="muy", client="Kodi Media Center" 2016-11-17 12:54:11.623 [ TRACE]:dvbcam: stop service 0x7f942b9f7af0 2016-11-17 12:54:11.625 [ INFO]:subscription: 0062: "192.168.0.67 [ muy | Kodi Media Center ]" subscribing on channel "SVT1 HD Väst", weight: 150, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", mux: "570MHz", provider: "Sveriges Television", service: "SVT1 HD Väst", profile="htsp", hostname="192.168.0.67", username="muy", client="Kodi Media Center" 2016-11-17 12:54:11.729 [ TRACE]:dvbcam: cannot find active service entry 2016-11-17 12:54:17.668 [ INFO]:subscription: 0062: "192.168.0.67 [ muy | Kodi Media Center ]" unsubscribing from "SVT1 HD Väst", hostname="192.168.0.67", username="muy", client="Kodi Media Center" 2016-11-17 12:54:17.669 [ TRACE]:dvbcam: stop service 0x7f942b9f8e30 2016-11-17 12:54:36.139 [ INFO]:htsp: 192.168.0.67 [ muy | Kodi Media Center ]: Disconnected 2016-11-17 12:54:53.640 [ INFO]:subscription: 0063: "SAT>IP" subscribing to mux "570MHz", weight: 150, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription", hostname="192.168.0.180" 2016-11-17 12:54:57.202 [ INFO]:subscription: 0063: "SAT>IP" unsubscribing, hostname="192.168.0.180" 2016-11-17 12:54:57.202 [ TRACE]:dvbcam: stop service 0x7f93ec001070 2016-11-17 12:54:57.204 [ INFO]:subscription: 0064: "SAT>IP" subscribing to mux "570MHz", weight: 150, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription", hostname="192.168.0.180" 2016-11-17 12:54:57.205 [ TRACE]:dvbcam: start service 0x7f942b9f6b20 2016-11-17 12:54:57.205 [ INFO]:subscription: 0065: "SAT>IP Slave/Teracom/570MHz/TV3 HD GÖTEBORG" subscribing to service "Teracom/570MHz/TV3 HD GÖTEBORG", weight: 100, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", mux: "570MHz", provider: "Viasat AB", client="SAT>IP Slave/Teracom/570MHz/TV3 HD GÖTEBORG" 2016-11-17 12:54:57.234 [ TRACE]:dvbcam: found active cam entry 2016-11-17 12:54:57.234 [ TRACE]:en50221: ok_descrambling CAPMT enqueued (only) 2016-11-17 12:54:57.234 [ TRACE]:dvbcam: start service 0x7f942b9f6b20 2016-11-17 12:54:57.404 [ TRACE]:en50221: ok_descrambling CAPMT sent (only) 2016-11-17 12:54:57.404 [ TRACE]:en50221: 03 0D 66 03 00 00 1B 0D 6F 00 34 01 09 0F 05 00 ..f.....o.4..... 2016-11-17 12:54:57.404 [ TRACE]:en50221: E0 BE 10 01 00 13 01 20 14 03 04 0D 08 09 0F 05 ....... ........ 2016-11-17 12:54:57.404 [ TRACE]:en50221: 00 E0 3F 10 01 00 13 01 20 14 03 02 05 08 09 0F ..?..... ....... 2016-11-17 12:54:57.404 [ TRACE]:en50221: 05 00 E0 40 10 01 00 13 01 20 14 03 02 32 08 11 ...@..... ...2.. 2016-11-17 12:54:57.404 [ TRACE]:en50221: 0D 6E 00 34 01 09 0F 05 00 E0 BE 10 01 00 13 01 .n.4............ 2016-11-17 12:54:57.404 [ TRACE]:en50221: 20 14 03 04 0D 08 09 0F 05 00 E0 3F 10 01 00 13 ..........?.... 2016-11-17 12:54:57.404 [ TRACE]:en50221: 01 20 14 03 02 05 08 09 0F 05 00 E0 40 10 01 00 . ..........@... 2016-11-17 12:54:57.404 [ TRACE]:en50221: 13 01 20 14 03 02 32 08 06 0B BE 00 00 .. ...2...... 2016-11-17 12:54:58.300 [WARNING]:TS: Teracom/570MHz/TV3 HD GÖTEBORG: H264 @ #3439 Continuity counter error (total 1) 2016-11-17 12:54:58.334 [WARNING]:TS: Teracom/570MHz/TV3 HD GÖTEBORG: AAC @ #3438 Continuity counter error (total 1) 2016-11-17 12:55:05.603 [ INFO]:subscription: 0065: "SAT>IP Slave/Teracom/570MHz/TV3 HD GÖTEBORG" unsubscribing, client="SAT>IP Slave/Teracom/570MHz/TV3 HD GÖTEBORG" 2016-11-17 12:55:05.603 [ TRACE]:dvbcam: stop service 0x7f942b9f6b20 2016-11-17 12:55:05.604 [ TRACE]:en50221: not_selected CAPMT enqueued (update) 2016-11-17 12:55:05.604 [ INFO]:subscription: 0064: "SAT>IP" unsubscribing, hostname="192.168.0.180" 2016-11-17 12:55:05.604 [ TRACE]:dvbcam: stop service 0x7f93ec038cc0 2016-11-17 12:55:05.604 [ TRACE]:en50221: not_selected CAPMT sent (update) 2016-11-17 12:55:05.604 [ TRACE]:en50221: 05 0D 66 03 00 00 1B 0D 6F 00 34 04 09 0F 05 00 ..f.....o.4..... 2016-11-17 12:55:05.604 [ TRACE]:en50221: E0 BE 10 01 00 13 01 20 14 03 04 0D 08 09 0F 05 ....... ........ 2016-11-17 12:55:05.604 [ TRACE]:en50221: 00 E0 3F 10 01 00 13 01 20 14 03 02 05 08 09 0F ..?..... ....... 2016-11-17 12:55:05.605 [ TRACE]:en50221: 05 00 E0 40 10 01 00 13 01 20 14 03 02 32 08 11 ...@..... ...2.. 2016-11-17 12:55:05.605 [ TRACE]:en50221: 0D 6E 00 34 04 09 0F 05 00 E0 BE 10 01 00 13 01 .n.4............ 2016-11-17 12:55:05.605 [ TRACE]:en50221: 20 14 03 04 0D 08 09 0F 05 00 E0 3F 10 01 00 13 ..........?.... 2016-11-17 12:55:05.605 [ TRACE]:en50221: 01 20 14 03 02 05 08 09 0F 05 00 E0 40 10 01 00 . ..........@... 2016-11-17 12:55:05.605 [ TRACE]:en50221: 13 01 20 14 03 02 32 08 06 0B BE 00 00 .. ...2...... 2016-11-17 12:55:05.605 [ INFO]:subscription: 0066: "SAT>IP" subscribing to mux "570MHz", weight: 150, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription", hostname="192.168.0.180" 2016-11-17 12:55:05.606 [ TRACE]:dvbcam: start service 0x7f942b9fc200 2016-11-17 12:55:05.606 [ INFO]:subscription: 0067: "SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" subscribing to service "Teracom/570MHz/TV4 HD Göteborg", weight: 100, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", mux: "570MHz", provider: "TV4 AB", client="SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" 2016-11-17 12:55:05.684 [ TRACE]:dvbcam: found active cam entry 2016-11-17 12:55:05.684 [ TRACE]:en50221: ok_descrambling CAPMT enqueued (only) 2016-11-17 12:55:05.687 [ TRACE]:dvbcam: start service 0x7f942b9fc200 2016-11-17 12:55:05.727 [ TRACE]:en50221: ok_descrambling CAPMT sent (only) 2016-11-17 12:55:05.727 [ TRACE]:en50221: 03 19 D2 05 00 00 1B 19 DB 00 34 01 09 0F 05 00 ..........4..... 2016-11-17 12:55:05.727 [ TRACE]:en50221: E0 BC 10 01 00 13 01 20 14 03 04 0D 08 09 0F 05 ....... ........ 2016-11-17 12:55:05.727 [ TRACE]:en50221: 00 E0 41 10 01 00 13 01 20 14 03 02 05 08 09 0F ..A..... ....... 2016-11-17 12:55:05.727 [ TRACE]:en50221: 05 00 E0 42 10 01 00 13 01 20 14 03 02 32 08 11 ...B..... ...2.. 2016-11-17 12:55:05.727 [ TRACE]:en50221: 19 DA 00 34 01 09 0F 05 00 E0 BC 10 01 00 13 01 ...4............ 2016-11-17 12:55:05.727 [ TRACE]:en50221: 20 14 03 04 0D 08 09 0F 05 00 E0 41 10 01 00 13 ..........A.... 2016-11-17 12:55:05.728 [ TRACE]:en50221: 01 20 14 03 02 05 08 09 0F 05 00 E0 42 10 01 00 . ..........B... 2016-11-17 12:55:05.728 [ TRACE]:en50221: 13 01 20 14 03 02 32 08 06 04 16 00 00 .. ...2...... 2016-11-17 12:55:07.230 [WARNING]:TS: Teracom/570MHz/TV4 HD Göteborg: H264 @ #6619 Continuity counter error (total 1) 2016-11-17 12:55:07.230 [WARNING]:TS: Teracom/570MHz/TV4 HD Göteborg: AAC @ #6618 Continuity counter error (total 1) 2016-11-17 12:55:33.409 [ INFO]:subscription: 0067: "SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" unsubscribing, client="SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" 2016-11-17 12:55:33.409 [ TRACE]:dvbcam: stop service 0x7f942b9fc200 2016-11-17 12:55:33.409 [ TRACE]:en50221: not_selected CAPMT enqueued (update) 2016-11-17 12:55:33.410 [ INFO]:subscription: 0066: "SAT>IP" unsubscribing, hostname="192.168.0.180" 2016-11-17 12:55:33.411 [ TRACE]:dvbcam: stop service 0x7f93ec038070 2016-11-17 12:55:33.414 [ INFO]:subscription: 0068: "SAT>IP" subscribing to mux "570MHz", weight: 150, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription", hostname="192.168.0.180" 2016-11-17 12:55:33.415 [ TRACE]:dvbcam: start service 0x7f942b9f7af0 2016-11-17 12:55:33.415 [ INFO]:subscription: 0069: "SAT>IP Slave/Teracom/570MHz/Kanal 5 HD" subscribing to service "Teracom/570MHz/Kanal 5 HD", weight: 100, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", mux: "570MHz", provider: "SBS Broadcasting Networks Ltd", client="SAT>IP Slave/Teracom/570MHz/Kanal 5 HD" 2016-11-17 12:55:33.419 [ TRACE]:en50221: not_selected CAPMT sent (update) 2016-11-17 12:55:33.419 [ TRACE]:en50221: 05 19 D2 05 00 00 1B 19 DB 00 34 04 09 0F 05 00 ..........4..... 2016-11-17 12:55:33.419 [ TRACE]:en50221: E0 BC 10 01 00 13 01 20 14 03 04 0D 08 09 0F 05 ....... ........ 2016-11-17 12:55:33.419 [ TRACE]:en50221: 00 E0 41 10 01 00 13 01 20 14 03 02 05 08 09 0F ..A..... ....... 2016-11-17 12:55:33.419 [ TRACE]:en50221: 05 00 E0 42 10 01 00 13 01 20 14 03 02 32 08 11 ...B..... ...2.. 2016-11-17 12:55:33.419 [ TRACE]:en50221: 19 DA 00 34 04 09 0F 05 00 E0 BC 10 01 00 13 01 ...4............ 2016-11-17 12:55:33.419 [ TRACE]:en50221: 20 14 03 04 0D 08 09 0F 05 00 E0 41 10 01 00 13 ..........A.... 2016-11-17 12:55:33.419 [ TRACE]:en50221: 01 20 14 03 02 05 08 09 0F 05 00 E0 42 10 01 00 . ..........B... 2016-11-17 12:55:33.419 [ TRACE]:en50221: 13 01 20 14 03 02 32 08 06 04 16 00 00 .. ...2...... 2016-11-17 12:55:33.521 [ TRACE]:dvbcam: found active cam entry 2016-11-17 12:55:33.521 [ TRACE]:en50221: ok_descrambling CAPMT enqueued (only) 2016-11-17 12:55:33.521 [ TRACE]:en50221: ok_descrambling CAPMT sent (only) 2016-11-17 12:55:33.522 [ TRACE]:en50221: 03 0D 7A 05 00 00 1B 0D 83 00 34 01 09 0F 05 00 ..z.......4..... 2016-11-17 12:55:33.522 [ TRACE]:en50221: E0 BD 10 01 00 13 01 20 14 03 04 0D 08 09 0F 05 ....... ........ 2016-11-17 12:55:33.522 [ TRACE]:en50221: 00 E0 43 10 01 00 13 01 20 14 03 02 05 08 09 0F ..C..... ....... 2016-11-17 12:55:33.522 [ TRACE]:en50221: 05 00 E0 44 10 01 00 13 01 20 14 03 02 32 08 11 ...D..... ...2.. 2016-11-17 12:55:33.522 [ TRACE]:en50221: 0D 82 00 34 01 09 0F 05 00 E0 BD 10 01 00 13 01 ...4............ 2016-11-17 12:55:33.522 [ TRACE]:en50221: 20 14 03 04 0D 08 09 0F 05 00 E0 43 10 01 00 13 ..........C.... 2016-11-17 12:55:33.522 [ TRACE]:en50221: 01 20 14 03 02 05 08 09 0F 05 00 E0 44 10 01 00 . ..........D... 2016-11-17 12:55:33.522 [ TRACE]:en50221: 13 01 20 14 03 02 32 08 06 0D B2 00 00 .. ...2...... 2016-11-17 12:55:33.523 [ TRACE]:dvbcam: start service 0x7f942b9f7af0 2016-11-17 12:55:35.224 [WARNING]:TS: Teracom/570MHz/Kanal 5 HD: H264 @ #3459 Continuity counter error (total 1) 2016-11-17 12:55:35.224 [WARNING]:TS: Teracom/570MHz/Kanal 5 HD: AAC @ #3458 Continuity counter error (total 1) 2016-11-17 12:55:44.404 [ INFO]:subscription: 0069: "SAT>IP Slave/Teracom/570MHz/Kanal 5 HD" unsubscribing, client="SAT>IP Slave/Teracom/570MHz/Kanal 5 HD" 2016-11-17 12:55:44.404 [ TRACE]:dvbcam: stop service 0x7f942b9f7af0 2016-11-17 12:55:44.404 [ TRACE]:en50221: not_selected CAPMT enqueued (update) 2016-11-17 12:55:44.404 [ INFO]:subscription: 0068: "SAT>IP" unsubscribing, hostname="192.168.0.180" 2016-11-17 12:55:44.405 [ TRACE]:dvbcam: stop service 0x7f93ec038070 2016-11-17 12:55:44.410 [ INFO]:subscription: 006A: "SAT>IP" subscribing to mux "570MHz", weight: 150, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", service: "Raw PID Subscription", hostname="192.168.0.180" 2016-11-17 12:55:44.410 [ TRACE]:dvbcam: start service 0x7f942b9fc200 2016-11-17 12:55:44.410 [ INFO]:subscription: 006B: "SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" subscribing to service "Teracom/570MHz/TV4 HD Göteborg", weight: 100, adapter: "TurboSight TBS 5881 DVBT/T2 frontend : DVB-T #0", network: "Teracom", mux: "570MHz", provider: "TV4 AB", client="SAT>IP Slave/Teracom/570MHz/TV4 HD Göteborg" 2016-11-17 12:55:44.429 [ TRACE]:en50221: not_selected CAPMT sent (update) 2016-11-17 12:55:44.429 [ TRACE]:en50221: 05 0D 7A 05 00 00 1B 0D 83 00 34 04 09 0F 05 00 ..z.......4..... 2016-11-17 12:55:44.429 [ TRACE]:en50221: E0 BD 10 01 00 13 01 20 14 03 04 0D 08 09 0F 05 ....... ........ 2016-11-17 12:55:44.429 [ TRACE]:en50221: 00 E0 43 10 01 00 13 01 20 14 03 02 05 08 09 0F ..C..... ....... 2016-11-17 12:55:44.429 [ TRACE]:en50221: 05 00 E0 44 10 01 00 13 01 20 14 03 02 32 08 11 ...D..... ...2.. 2016-11-17 12:55:44.430 [ TRACE]:en50221: 0D 82 00 34 04 09 0F 05 00 E0 BD 10 01 00 13 01 ...4............ 2016-11-17 12:55:44.430 [ TRACE]:en50221: 20 14 03 04 0D 08 09 0F 05 00 E0 43 10 01 00 13 ..........C.... 2016-11-17 12:55:44.430 [ TRACE]:en50221: 01 20 14 03 02 05 08 09 0F 05 00 E0 44 10 01 00 . ..........D... 2016-11-17 12:55:44.430 [ TRACE]:en50221: 13 01 20 14 03 02 32 08 06 0D B2 00 00 .. ...2...... 2016-11-17 12:55:44.466 [ TRACE]:dvbcam: found active cam entry 2016-11-17 12:55:44.466 [ TRACE]:en50221: ok_descrambling CAPMT enqueued (only) 2016-11-17 12:55:44.467 [ TRACE]:dvbcam: start service 0x7f942b9fc200 2016-11-17 12:55:44.495 [ TRACE]:en50221: ok_descrambling CAPMT sent (only) 2016-11-17 12:55:44.496 [ TRACE]:en50221: 03 19 D2 05 00 00 1B 19 DB 00 34 01 09 0F 05 00 ..........4..... 2016-11-17 12:55:44.496 [ TRACE]:en50221: E0 BC 10 01 00 13 01 20 14 03 04 0D 08 09 0F 05 ....... ........ 2016-11-17 12:55:44.496 [ TRACE]:en50221: 00 E0 41 10 01 00 13 01 20 14 03 02 05 08 09 0F ..A..... ....... 2016-11-17 12:55:44.496 [ TRACE]:en50221: 05 00 E0 42 10 01 00 13 01 20 14 03 02 32 08 11 ...B..... ...2.. 2016-11-17 12:55:44.496 [ TRACE]:en50221: 19 DA 00 34 01 09 0F 05 00 E0 BC 10 01 00 13 01 ...4............ 2016-11-17 12:55:44.496 [ TRACE]:en50221: 20 14 03 04 0D 08 09 0F 05 00 E0 41 10 01 00 13 ..........A.... 2016-11-17 12:55:44.496 [ TRACE]:en50221: 01 20 14 03 02 05 08 09 0F 05 00 E0 42 10 01 00 . ..........B... 2016-11-17 12:55:44.496 [ TRACE]:en50221: 13 01 20 14 03 02 32 08 06 04 16 00 00 .. ...2...... 2016-11-17 12:55:46.231 [WARNING]:TS: Teracom/570MHz/TV4 HD Göteborg: H264 @ #6619 Continuity counter error (total 1) 2016-11-17 12:55:46.231 [WARNING]:TS: Teracom/570MHz/TV4 HD Göteborg: AAC @ #6618 Continuity counter error (total 1)