Project

General

Profile

Bug #4303 » trace_without_continious_descrambling.txt

Thorsten Krohn, 2017-04-05 09:03

 
1
2017-04-05 08:41:05.369 [   INFO]:http: 192.168.50.50: using ticket B4098882D73BF376A058CD57095A1E1F8152E843 for /stream/service/f4f2f5a6dbf56f20e174619a77cccc3f
2
2017-04-05 08:41:05.371 [  TRACE]:subscription: 0012: creating subscription for service wilhelm.tel/362MHz/Duck TV HD (WT) weight 0 using profile pass
3
2017-04-05 08:41:05.371 [  TRACE]:subscription: 0012: find instance for wilhelm.tel/362MHz/Duck TV HD (WT) weight 100
4
2017-04-05 08:41:05.371 [  DEBUG]:service: 13: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f264000eff0 Tuner 4 weight 0 prio 10 error 0
5
2017-04-05 08:41:05.371 [  DEBUG]:service: 12: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f2640004e10 Tuner 3 weight 0 prio 10 error 0
6
2017-04-05 08:41:05.371 [  DEBUG]:service: 11: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f264000f440 Tuner 2 weight 0 prio 10 error 0
7
2017-04-05 08:41:05.371 [  DEBUG]:service: 10: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f2640033960 Tuner 1 weight 0 prio 10 error 0
8
2017-04-05 08:41:05.371 [  TRACE]:service: will start new instance 10
9
2017-04-05 08:41:05.371 [  TRACE]:service: starting wilhelm.tel/362MHz/Duck TV HD (WT)
10
2017-04-05 08:41:05.371 [   INFO]:mpegts: 362MHz in wilhelm.tel - tuning on Tuner 1
11
2017-04-05 08:41:05.371 [   INFO]:tvhdhomerun: tuning to auto:362000000
12
2017-04-05 08:41:05.377 [   INFO]:capmt: Local-Proxy: Starting CAPMT server for service "Duck TV HD (WT)" on adapter 0
13
2017-04-05 08:41:05.377 [  TRACE]:subscription: 0012: linking sub 0x7f25f8000fd0 to svc 0x557f7777e650 type 0
14
2017-04-05 08:41:05.377 [   INFO]:subscription: 0012: "HTTP" subscribing to service "wilhelm.tel/362MHz/Duck TV HD (WT)", weight: 100, adapter: "Tuner 1", network: "wilhelm.tel", mux: "362MHz", provider: "wt Pay-TV", profile="pass", hostname="192.168.50.50", client="VLC/2.2.4 LibVLC/2.2.4"
15
2017-04-05 08:41:05.377 [  TRACE]:subscription: 0012:  chain 01: input
16
2017-04-05 08:41:05.377 [  TRACE]:subscription: 0012:  chain 02: streaming queue 0x7f2625fe22c8 size 0
17
2017-04-05 08:41:05.378 [  TRACE]:descrambler: mux 0x557f77777d70 open pid 1626 (5670) (flags 0x0100) for 0x7f2678d83c48
18
2017-04-05 08:41:06.098 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input]
19
2017-04-05 08:41:06.098 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service]
20
2017-04-05 08:41:06.098 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [No access]
21
2017-04-05 08:41:06.129 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
22
2017-04-05 08:41:06.129 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets] [No access]
23
2017-04-05 08:41:06.156 [  TRACE]:descrambler: ECM message 80 (section 98, len 103, pid 5670) for service "Duck TV HD (WT)"
24
2017-04-05 08:41:06.179 [  TRACE]:descrambler: initial stream key set to even for service "Duck TV HD (WT)"
25
2017-04-05 08:41:06.303 [  DEBUG]:descrambler: Obtained keys from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
26
2017-04-05 08:41:06.303 [  TRACE]:descrambler: Obtained keys 8444460EE7B223BC:0000000000000000 from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
27
2017-04-05 08:41:06.303 [  TRACE]:descrambler: Obtained keys 0000000000000000:9CB32473E9A446D3 from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
28
2017-04-05 08:41:06.303 [  DEBUG]:descrambler: info - service='Duck TV HD (WT)' caid=0B00(conax) provid=000000 ecmtime=146 hops=0 reader='willy_hd' from='local' protocol='mouse'
29
2017-04-05 08:41:06.327 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets]
30
2017-04-05 08:41:06.537 [  TRACE]:descrambler: CAT data (len 6)
31
2017-04-05 08:41:06.537 [  TRACE]:descrambler: 09 04 0B 00 E0 30                               .....0
32
2017-04-05 08:41:07.371 [WARNING]:subscription: 0012: service instance is bad, reason: No access
33
2017-04-05 08:41:07.373 [  TRACE]:descrambler: mux 0x557f77777d70 - flush tables
34
2017-04-05 08:41:07.373 [  TRACE]:subscription: 0012: find instance for wilhelm.tel/362MHz/Duck TV HD (WT) weight 100
35
2017-04-05 08:41:07.373 [  DEBUG]:service: 13: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f264000eff0 Tuner 4 weight 0 prio 10 error 0
36
2017-04-05 08:41:07.373 [  DEBUG]:service: 12: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f2640004e10 Tuner 3 weight 0 prio 10 error 0
37
2017-04-05 08:41:07.373 [  DEBUG]:service: 11: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f264000f440 Tuner 2 weight 0 prio 10 error 0
38
2017-04-05 08:41:07.373 [  DEBUG]:service: 10: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f2640033960 Tuner 1 weight 0 prio 10 error 401
39
2017-04-05 08:41:07.373 [  TRACE]:service: will start new instance 11
40
2017-04-05 08:41:07.373 [  TRACE]:service: starting wilhelm.tel/362MHz/Duck TV HD (WT)
41
2017-04-05 08:41:07.373 [   INFO]:mpegts: 362MHz in wilhelm.tel - tuning on Tuner 2
42
2017-04-05 08:41:07.373 [   INFO]:tvhdhomerun: tuning to auto:362000000
43
2017-04-05 08:41:07.379 [   INFO]:capmt: Local-Proxy: Starting CAPMT server for service "Duck TV HD (WT)" on adapter 0
44
2017-04-05 08:41:07.379 [  TRACE]:subscription: 0012: linking sub 0x7f25f8000fd0 to svc 0x557f7777e650 type 0
45
2017-04-05 08:41:07.379 [   INFO]:subscription: 0012: "HTTP" subscribing to service "wilhelm.tel/362MHz/Duck TV HD (WT)", weight: 100, adapter: "Tuner 2", network: "wilhelm.tel", mux: "362MHz", provider: "wt Pay-TV", profile="pass", hostname="192.168.50.50", client="VLC/2.2.4 LibVLC/2.2.4"
46
2017-04-05 08:41:07.379 [  TRACE]:subscription: 0012:  chain 01: input
47
2017-04-05 08:41:07.379 [  TRACE]:subscription: 0012:  chain 02: streaming queue 0x7f2625fe22c8 size 0
48
2017-04-05 08:41:07.419 [  TRACE]:descrambler: mux 0x557f77777d70 open pid 1626 (5670) (flags 0x0100) for 0x7f2678d83c48
49
2017-04-05 08:41:08.100 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input]
50
2017-04-05 08:41:08.100 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service]
51
2017-04-05 08:41:08.100 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [No access]
52
2017-04-05 08:41:08.100 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
53
2017-04-05 08:41:08.185 [  TRACE]:descrambler: ECM message 80 (section 98, len 103, pid 5670) for service "Duck TV HD (WT)"
54
2017-04-05 08:41:08.185 [  TRACE]:descrambler: initial stream key set to even for service "Duck TV HD (WT)"
55
2017-04-05 08:41:08.186 [  DEBUG]:descrambler: Obtained keys from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
56
2017-04-05 08:41:08.186 [  TRACE]:descrambler: Obtained keys 8444460EE7B223BC:0000000000000000 from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
57
2017-04-05 08:41:08.186 [  TRACE]:descrambler: Obtained keys 0000000000000000:9CB32473E9A446D3 from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
58
2017-04-05 08:41:08.186 [  DEBUG]:descrambler: info - service='Duck TV HD (WT)' caid=0B00(conax) provid=000000 ecmtime=0 hops=0 reader='Cache' from='cache2' protocol='none'
59
2017-04-05 08:41:08.212 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets] [No access]
60
2017-04-05 08:41:08.212 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets]
61
2017-04-05 08:41:08.433 [  TRACE]:descrambler: CAT data (len 6)
62
2017-04-05 08:41:08.433 [  TRACE]:descrambler: 09 04 0B 00 E0 30                               .....0
63
2017-04-05 08:41:09.372 [WARNING]:subscription: 0012: service instance is bad, reason: No access
64
2017-04-05 08:41:09.373 [  TRACE]:descrambler: mux 0x557f77777d70 - flush tables
65
2017-04-05 08:41:09.374 [  TRACE]:subscription: 0012: find instance for wilhelm.tel/362MHz/Duck TV HD (WT) weight 100
66
2017-04-05 08:41:09.374 [  DEBUG]:service: 13: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f264000eff0 Tuner 4 weight 0 prio 10 error 0
67
2017-04-05 08:41:09.374 [  DEBUG]:service: 12: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f2640004e10 Tuner 3 weight 0 prio 10 error 0
68
2017-04-05 08:41:09.374 [  DEBUG]:service: 11: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f264000f440 Tuner 2 weight 0 prio 10 error 401
69
2017-04-05 08:41:09.374 [  DEBUG]:service: 10: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f2640033960 Tuner 1 weight 0 prio 10 error 401
70
2017-04-05 08:41:09.374 [  TRACE]:service: will start new instance 12
71
2017-04-05 08:41:09.374 [  TRACE]:service: starting wilhelm.tel/362MHz/Duck TV HD (WT)
72
2017-04-05 08:41:09.374 [   INFO]:mpegts: 362MHz in wilhelm.tel - tuning on Tuner 3
73
2017-04-05 08:41:09.374 [   INFO]:tvhdhomerun: tuning to auto:362000000
74
2017-04-05 08:41:09.380 [   INFO]:capmt: Local-Proxy: Starting CAPMT server for service "Duck TV HD (WT)" on adapter 0
75
2017-04-05 08:41:09.380 [  TRACE]:subscription: 0012: linking sub 0x7f25f8000fd0 to svc 0x557f7777e650 type 0
76
2017-04-05 08:41:09.380 [   INFO]:subscription: 0012: "HTTP" subscribing to service "wilhelm.tel/362MHz/Duck TV HD (WT)", weight: 100, adapter: "Tuner 3", network: "wilhelm.tel", mux: "362MHz", provider: "wt Pay-TV", profile="pass", hostname="192.168.50.50", client="VLC/2.2.4 LibVLC/2.2.4"
77
2017-04-05 08:41:09.380 [  TRACE]:subscription: 0012:  chain 01: input
78
2017-04-05 08:41:09.380 [  TRACE]:subscription: 0012:  chain 02: streaming queue 0x7f2625fe22c8 size 0
79
2017-04-05 08:41:09.428 [  TRACE]:descrambler: mux 0x557f77777d70 open pid 1626 (5670) (flags 0x0100) for 0x7f2678d83c48
80
2017-04-05 08:41:10.101 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input]
81
2017-04-05 08:41:10.101 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service]
82
2017-04-05 08:41:10.101 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [No access]
83
2017-04-05 08:41:10.101 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
84
2017-04-05 08:41:10.185 [  TRACE]:descrambler: ECM message 80 (section 98, len 103, pid 5670) for service "Duck TV HD (WT)"
85
2017-04-05 08:41:10.185 [  TRACE]:descrambler: initial stream key set to even for service "Duck TV HD (WT)"
86
2017-04-05 08:41:10.186 [  DEBUG]:descrambler: Obtained keys from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
87
2017-04-05 08:41:10.186 [  TRACE]:descrambler: Obtained keys 8444460EE7B223BC:0000000000000000 from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
88
2017-04-05 08:41:10.186 [  TRACE]:descrambler: Obtained keys 0000000000000000:9CB32473E9A446D3 from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
89
2017-04-05 08:41:10.186 [  DEBUG]:descrambler: info - service='Duck TV HD (WT)' caid=0B00(conax) provid=000000 ecmtime=1 hops=0 reader='Cache' from='cache2' protocol='none'
90
2017-04-05 08:41:10.224 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets] [No access]
91
2017-04-05 08:41:10.224 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets]
92
2017-04-05 08:41:10.333 [  TRACE]:descrambler: CAT data (len 6)
93
2017-04-05 08:41:10.333 [  TRACE]:descrambler: 09 04 0B 00 E0 30                               .....0
94
2017-04-05 08:41:11.372 [WARNING]:subscription: 0012: service instance is bad, reason: No access
95
2017-04-05 08:41:11.373 [  TRACE]:descrambler: mux 0x557f77777d70 - flush tables
96
2017-04-05 08:41:11.374 [  TRACE]:subscription: 0012: find instance for wilhelm.tel/362MHz/Duck TV HD (WT) weight 100
97
2017-04-05 08:41:11.374 [  DEBUG]:service: 13: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f264000eff0 Tuner 4 weight 0 prio 10 error 0
98
2017-04-05 08:41:11.374 [  DEBUG]:service: 12: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f2640004e10 Tuner 3 weight 0 prio 10 error 401
99
2017-04-05 08:41:11.374 [  DEBUG]:service: 11: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f264000f440 Tuner 2 weight 0 prio 10 error 401
100
2017-04-05 08:41:11.374 [  DEBUG]:service: 10: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f2640033960 Tuner 1 weight 0 prio 10 error 401
101
2017-04-05 08:41:11.374 [  TRACE]:service: will start new instance 13
102
2017-04-05 08:41:11.374 [  TRACE]:service: starting wilhelm.tel/362MHz/Duck TV HD (WT)
103
2017-04-05 08:41:11.374 [   INFO]:mpegts: 362MHz in wilhelm.tel - tuning on Tuner 4
104
2017-04-05 08:41:11.374 [   INFO]:tvhdhomerun: tuning to auto:362000000
105
2017-04-05 08:41:11.379 [   INFO]:capmt: Local-Proxy: Starting CAPMT server for service "Duck TV HD (WT)" on adapter 0
106
2017-04-05 08:41:11.379 [  TRACE]:subscription: 0012: linking sub 0x7f25f8000fd0 to svc 0x557f7777e650 type 0
107
2017-04-05 08:41:11.379 [   INFO]:subscription: 0012: "HTTP" subscribing to service "wilhelm.tel/362MHz/Duck TV HD (WT)", weight: 100, adapter: "Tuner 4", network: "wilhelm.tel", mux: "362MHz", provider: "wt Pay-TV", profile="pass", hostname="192.168.50.50", client="VLC/2.2.4 LibVLC/2.2.4"
108
2017-04-05 08:41:11.379 [  TRACE]:subscription: 0012:  chain 01: input
109
2017-04-05 08:41:11.379 [  TRACE]:subscription: 0012:  chain 02: streaming queue 0x7f2625fe22c8 size 0
110
2017-04-05 08:41:11.424 [  TRACE]:descrambler: mux 0x557f77777d70 open pid 1626 (5670) (flags 0x0100) for 0x7f2678d83c48
111
2017-04-05 08:41:12.099 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input]
112
2017-04-05 08:41:12.099 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service]
113
2017-04-05 08:41:12.099 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [No access]
114
2017-04-05 08:41:12.099 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
115
2017-04-05 08:41:12.099 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets] [No access]
116
2017-04-05 08:41:12.157 [  TRACE]:descrambler: ECM message 80 (section 98, len 103, pid 5670) for service "Duck TV HD (WT)"
117
2017-04-05 08:41:12.158 [  DEBUG]:descrambler: Obtained keys from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
118
2017-04-05 08:41:12.158 [  TRACE]:descrambler: Obtained keys 8444460EE7B223BC:0000000000000000 from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
119
2017-04-05 08:41:12.158 [  TRACE]:descrambler: Obtained keys 0000000000000000:9CB32473E9A446D3 from capmt-127.0.0.1-9000 for service "Duck TV HD (WT)"
120
2017-04-05 08:41:12.158 [  DEBUG]:descrambler: info - service='Duck TV HD (WT)' caid=0B00(conax) provid=000000 ecmtime=1 hops=0 reader='Cache' from='cache2' protocol='none'
121
2017-04-05 08:41:12.185 [  TRACE]:descrambler: stream key changed to even for service "Duck TV HD (WT)"
122
2017-04-05 08:41:12.185 [  DEBUG]:service: wilhelm.tel/362MHz/Duck TV HD (WT): Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets]
123
2017-04-05 08:41:12.256 [  TRACE]:descrambler: CAT data (len 6)
124
2017-04-05 08:41:12.256 [  TRACE]:descrambler: 09 04 0B 00 E0 30                               .....0
125
2017-04-05 08:41:13.372 [WARNING]:subscription: 0012: service instance is bad, reason: No access
126
2017-04-05 08:41:13.373 [  TRACE]:descrambler: mux 0x557f77777d70 - flush tables
127
2017-04-05 08:41:13.374 [  TRACE]:subscription: 0012: find instance for wilhelm.tel/362MHz/Duck TV HD (WT) weight 100
128
2017-04-05 08:41:13.374 [  DEBUG]:service: 13: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f264000eff0 Tuner 4 weight 0 prio 10 error 401
129
2017-04-05 08:41:13.374 [  DEBUG]:service: 12: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f2640004e10 Tuner 3 weight 0 prio 10 error 401
130
2017-04-05 08:41:13.374 [  DEBUG]:service: 11: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f264000f440 Tuner 2 weight 0 prio 10 error 401
131
2017-04-05 08:41:13.374 [  DEBUG]:service: 10: wilhelm.tel/362MHz/Duck TV HD (WT) si 0x7f2640033960 Tuner 1 weight 0 prio 10 error 401
132
2017-04-05 08:41:13.374 [  TRACE]:subscription: 0012: instance not available, retrying
133
2017-04-05 08:41:14.324 [   INFO]:subscription: 0012: "HTTP" unsubscribing, hostname="192.168.50.50", client="VLC/2.2.4 LibVLC/2.2.4"
(2-2/9)